builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1452484952.24 results: success (0) buildid: 20160110193316 builduid: e3dbb42aff384a9eabffc38fe1298a29 revision: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.245202) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.245636) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.245956) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006457 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.284720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.285046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.353905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.354215) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.415175) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.415770) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.416450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.417027) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 20:02:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.2M=0s 2016-01-10 20:02:33 (84.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099177 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.529996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.530338) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.580318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:32.580692) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 60a85952d9fdbd2740d6764aaf172735a37e1ca7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 60a85952d9fdbd2740d6764aaf172735a37e1ca7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 20:02:33,151 truncating revision to first 12 chars 2016-01-10 20:02:33,151 Setting DEBUG logging. 2016-01-10 20:02:33,151 attempt 1/10 2016-01-10 20:02:33,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/60a85952d9fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 20:02:33,536 unpacking tar archive at: b2g-inbound-60a85952d9fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:33.289686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:33.290030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:33.298129) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:33.298422) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 20:02:33.298885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-10 20:02:33.299204) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:02:33 INFO - MultiFileLogger online at 20160110 20:02:33 in /builds/slave/test 20:02:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 20:02:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:02:33 INFO - {'append_to_log': False, 20:02:33 INFO - 'base_work_dir': '/builds/slave/test', 20:02:33 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 20:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:02:33 INFO - 'branch': 'B2G-Inbound-Non-PGO', 20:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:33 INFO - 'config_files': ('talos/linux_config.py',), 20:02:33 INFO - 'default_actions': ('clobber', 20:02:33 INFO - 'read-buildbot-config', 20:02:33 INFO - 'download-and-extract', 20:02:33 INFO - 'populate-webroot', 20:02:33 INFO - 'create-virtualenv', 20:02:33 INFO - 'install', 20:02:33 INFO - 'run-tests'), 20:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:33 INFO - 'download_minidump_stackwalk': True, 20:02:33 INFO - 'download_symbols': 'ondemand', 20:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:33 INFO - 'installer_path': 'installer.exe', 20:02:33 INFO - 'log_level': 'info', 20:02:33 INFO - 'log_name': 'talos', 20:02:33 INFO - 'log_to_console': True, 20:02:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:02:33 INFO - 'opt_config_files': (), 20:02:33 INFO - 'pip_index': False, 20:02:33 INFO - 'sps_profile': False, 20:02:33 INFO - 'sps_profile_interval': 0, 20:02:33 INFO - 'suite': 'dromaeojs', 20:02:33 INFO - 'system_bits': '32', 20:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:33 INFO - 'title': 'talos-linux64-ix-037', 20:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:33 INFO - 'use_talos_json': True, 20:02:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:33 INFO - 'work_dir': 'build'} 20:02:33 INFO - ##### 20:02:33 INFO - ##### Running clobber step. 20:02:33 INFO - ##### 20:02:33 INFO - Running pre-action listener: _resource_record_pre_action 20:02:33 INFO - Running main action method: clobber 20:02:33 INFO - rmtree: /builds/slave/test/build 20:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:02:34 INFO - Running post-action listener: _resource_record_post_action 20:02:34 INFO - ##### 20:02:34 INFO - ##### Running read-buildbot-config step. 20:02:34 INFO - ##### 20:02:34 INFO - Running pre-action listener: _resource_record_pre_action 20:02:34 INFO - Running main action method: read_buildbot_config 20:02:34 INFO - Using buildbot properties: 20:02:34 INFO - { 20:02:34 INFO - "project": "", 20:02:34 INFO - "product": "firefox", 20:02:34 INFO - "script_repo_revision": "production", 20:02:34 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:02:34 INFO - "repository": "", 20:02:34 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 20:02:34 INFO - "buildid": "20160110193316", 20:02:34 INFO - "pgo_build": "False", 20:02:34 INFO - "basedir": "/builds/slave/test", 20:02:34 INFO - "buildnumber": 331, 20:02:34 INFO - "slavename": "talos-linux64-ix-037", 20:02:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:02:34 INFO - "platform": "ubuntu64_hw", 20:02:34 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 20:02:34 INFO - "branch": "b2g-inbound", 20:02:34 INFO - "repo_path": "integration/b2g-inbound", 20:02:34 INFO - "revision": "60a85952d9fdbd2740d6764aaf172735a37e1ca7", 20:02:34 INFO - "stage_platform": "linux64", 20:02:34 INFO - "builduid": "e3dbb42aff384a9eabffc38fe1298a29", 20:02:34 INFO - "slavebuilddir": "test" 20:02:34 INFO - } 20:02:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:02:34 INFO - Running post-action listener: _resource_record_post_action 20:02:34 INFO - ##### 20:02:34 INFO - ##### Running download-and-extract step. 20:02:34 INFO - ##### 20:02:34 INFO - Running pre-action listener: _resource_record_pre_action 20:02:34 INFO - Running main action method: download_and_extract 20:02:34 INFO - mkdir: /builds/slave/test/build/tests 20:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:34 INFO - https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/test_packages.json 20:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/test_packages.json 20:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:02:37 INFO - Downloaded 1302 bytes. 20:02:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:02:37 INFO - Using the following test package requirements: 20:02:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:02:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'jsshell-linux-x86_64.zip'], 20:02:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:02:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:02:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:02:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:02:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:02:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:02:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:37 INFO - https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:39 INFO - Downloaded 22761327 bytes. 20:02:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:02:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:02:40 INFO - Return code: 0 20:02:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:40 INFO - https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:02:44 INFO - Downloaded 22761327 bytes. 20:02:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:02:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:02:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:02:46 INFO - Return code: 0 20:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:46 INFO - https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:02:48 INFO - Downloaded 11132285 bytes. 20:02:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:02:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:02:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:02:48 INFO - Return code: 0 20:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:48 INFO - https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:02:52 INFO - Downloaded 54054379 bytes. 20:02:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:52 INFO - mkdir: /builds/slave/test/properties 20:02:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:02:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:02:52 INFO - Contents: 20:02:52 INFO - build_url:https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:02:52 INFO - Running post-action listener: _resource_record_post_action 20:02:52 INFO - Running post-action listener: set_extra_try_arguments 20:02:52 INFO - ##### 20:02:52 INFO - ##### Running populate-webroot step. 20:02:52 INFO - ##### 20:02:52 INFO - Running pre-action listener: _resource_record_pre_action 20:02:52 INFO - Running main action method: populate_webroot 20:02:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:02:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:02:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:02:52 INFO - '--tppagecycles', 20:02:52 INFO - '7'], 20:02:52 INFO - 'tests': ['tsvgm']}}, 20:02:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:02:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:02:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:02:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:02:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:02:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'tests': ['damp', 'tps']}, 20:02:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['damp', 'tps']}, 20:02:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:02:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:02:52 INFO - 'other': {'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'other_l64': {'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'other_nol64': {'tests': ['a11yr', 20:02:52 INFO - 'ts_paint', 20:02:52 INFO - 'tpaint', 20:02:52 INFO - 'sessionrestore', 20:02:52 INFO - 'sessionrestore_no_auto_restore']}, 20:02:52 INFO - 'svgr': {'tests': ['tsvgx', 20:02:52 INFO - 'tsvgr_opacity', 20:02:52 INFO - 'tart', 20:02:52 INFO - 'tscrollx', 20:02:52 INFO - 'cart']}, 20:02:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['tsvgx', 20:02:52 INFO - 'tsvgr_opacity', 20:02:52 INFO - 'tart', 20:02:52 INFO - 'tscrollx', 20:02:52 INFO - 'cart']}, 20:02:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'tests': ['tp5o']}, 20:02:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'talos_options': ['--e10s'], 20:02:52 INFO - 'tests': ['tp5o']}, 20:02:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'talos_options': ['--xperf_path', 20:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:52 INFO - 'tests': ['tp5n']}, 20:02:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:02:52 INFO - 'talos_options': ['--e10s', 20:02:52 INFO - '--xperf_path', 20:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:02:52 INFO - 'tests': ['tp5n']}}, 20:02:52 INFO - 'talos.zip': {'path': '', 20:02:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:02:52 INFO - Running post-action listener: _resource_record_post_action 20:02:52 INFO - ##### 20:02:52 INFO - ##### Running create-virtualenv step. 20:02:52 INFO - ##### 20:02:52 INFO - Running pre-action listener: _resource_record_pre_action 20:02:52 INFO - Running main action method: create_virtualenv 20:02:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:02:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:02:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:02:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:02:52 INFO - Using real prefix '/usr' 20:02:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:02:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:02:54 INFO - Installing pip.................done. 20:02:54 INFO - Return code: 0 20:02:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:02:54 INFO - Using env: {'DISPLAY': ':0', 20:02:54 INFO - 'HOME': '/home/cltbld', 20:02:54 INFO - 'LANG': 'en_US.UTF-8', 20:02:54 INFO - 'LANGUAGE': 'en_US:en', 20:02:54 INFO - 'LOGNAME': 'cltbld', 20:02:54 INFO - 'MAIL': '/var/mail/cltbld', 20:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:54 INFO - 'MOZ_NO_REMOTE': '1', 20:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:54 INFO - 'NO_EM_RESTART': '1', 20:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:54 INFO - 'PWD': '/builds/slave/test', 20:02:54 INFO - 'SHELL': '/bin/bash', 20:02:54 INFO - 'SHLVL': '1', 20:02:54 INFO - 'TERM': 'linux', 20:02:54 INFO - 'TMOUT': '86400', 20:02:54 INFO - 'USER': 'cltbld', 20:02:54 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:54 INFO - '_': '/tools/buildbot/bin/python'} 20:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:02:54 INFO - Cleaning up... 20:02:54 INFO - Return code: 0 20:02:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:02:54 INFO - Using env: {'DISPLAY': ':0', 20:02:54 INFO - 'HOME': '/home/cltbld', 20:02:54 INFO - 'LANG': 'en_US.UTF-8', 20:02:54 INFO - 'LANGUAGE': 'en_US:en', 20:02:54 INFO - 'LOGNAME': 'cltbld', 20:02:54 INFO - 'MAIL': '/var/mail/cltbld', 20:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:54 INFO - 'MOZ_NO_REMOTE': '1', 20:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:54 INFO - 'NO_EM_RESTART': '1', 20:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:54 INFO - 'PWD': '/builds/slave/test', 20:02:54 INFO - 'SHELL': '/bin/bash', 20:02:54 INFO - 'SHLVL': '1', 20:02:54 INFO - 'TERM': 'linux', 20:02:54 INFO - 'TMOUT': '86400', 20:02:54 INFO - 'USER': 'cltbld', 20:02:54 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:54 INFO - '_': '/tools/buildbot/bin/python'} 20:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:55 INFO - Downloading/unpacking psutil>=0.7.1 20:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:02:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:56 INFO - Installing collected packages: psutil 20:02:56 INFO - Running setup.py install for psutil 20:02:56 INFO - building 'psutil._psutil_linux' extension 20:02:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:02:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:02:57 INFO - building 'psutil._psutil_posix' extension 20:02:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:02:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:02:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:02:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:02:57 INFO - Successfully installed psutil 20:02:57 INFO - Cleaning up... 20:02:57 INFO - Return code: 0 20:02:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:02:57 INFO - Using env: {'DISPLAY': ':0', 20:02:57 INFO - 'HOME': '/home/cltbld', 20:02:57 INFO - 'LANG': 'en_US.UTF-8', 20:02:57 INFO - 'LANGUAGE': 'en_US:en', 20:02:57 INFO - 'LOGNAME': 'cltbld', 20:02:57 INFO - 'MAIL': '/var/mail/cltbld', 20:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:57 INFO - 'MOZ_NO_REMOTE': '1', 20:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:57 INFO - 'NO_EM_RESTART': '1', 20:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:57 INFO - 'PWD': '/builds/slave/test', 20:02:57 INFO - 'SHELL': '/bin/bash', 20:02:57 INFO - 'SHLVL': '1', 20:02:57 INFO - 'TERM': 'linux', 20:02:57 INFO - 'TMOUT': '86400', 20:02:57 INFO - 'USER': 'cltbld', 20:02:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:57 INFO - '_': '/tools/buildbot/bin/python'} 20:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:02:59 INFO - Installing collected packages: mozsystemmonitor 20:02:59 INFO - Running setup.py install for mozsystemmonitor 20:02:59 INFO - Successfully installed mozsystemmonitor 20:02:59 INFO - Cleaning up... 20:02:59 INFO - Return code: 0 20:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:02:59 INFO - Using env: {'DISPLAY': ':0', 20:02:59 INFO - 'HOME': '/home/cltbld', 20:02:59 INFO - 'LANG': 'en_US.UTF-8', 20:02:59 INFO - 'LANGUAGE': 'en_US:en', 20:02:59 INFO - 'LOGNAME': 'cltbld', 20:02:59 INFO - 'MAIL': '/var/mail/cltbld', 20:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:59 INFO - 'MOZ_NO_REMOTE': '1', 20:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:59 INFO - 'NO_EM_RESTART': '1', 20:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:02:59 INFO - 'PWD': '/builds/slave/test', 20:02:59 INFO - 'SHELL': '/bin/bash', 20:02:59 INFO - 'SHLVL': '1', 20:02:59 INFO - 'TERM': 'linux', 20:02:59 INFO - 'TMOUT': '86400', 20:02:59 INFO - 'USER': 'cltbld', 20:02:59 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:59 INFO - '_': '/tools/buildbot/bin/python'} 20:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:02 INFO - Downloading docopt-0.6.1.tar.gz 20:03:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:02 INFO - Running setup.py install for blobuploader 20:03:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:02 INFO - Running setup.py install for requests 20:03:02 INFO - Running setup.py install for docopt 20:03:02 INFO - Successfully installed blobuploader requests docopt 20:03:02 INFO - Cleaning up... 20:03:02 INFO - Return code: 0 20:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:02 INFO - Using env: {'DISPLAY': ':0', 20:03:02 INFO - 'HOME': '/home/cltbld', 20:03:02 INFO - 'LANG': 'en_US.UTF-8', 20:03:02 INFO - 'LANGUAGE': 'en_US:en', 20:03:02 INFO - 'LOGNAME': 'cltbld', 20:03:02 INFO - 'MAIL': '/var/mail/cltbld', 20:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:02 INFO - 'MOZ_NO_REMOTE': '1', 20:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:02 INFO - 'NO_EM_RESTART': '1', 20:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:02 INFO - 'PWD': '/builds/slave/test', 20:03:02 INFO - 'SHELL': '/bin/bash', 20:03:02 INFO - 'SHLVL': '1', 20:03:02 INFO - 'TERM': 'linux', 20:03:02 INFO - 'TMOUT': '86400', 20:03:02 INFO - 'USER': 'cltbld', 20:03:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:02 INFO - '_': '/tools/buildbot/bin/python'} 20:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:03 INFO - Running setup.py (path:/tmp/pip-vUxMBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:03 INFO - Running setup.py (path:/tmp/pip-GSyH6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:03 INFO - Running setup.py (path:/tmp/pip-61EOkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:03 INFO - Running setup.py (path:/tmp/pip-HBcAcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:03 INFO - Running setup.py (path:/tmp/pip-5pGmPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:03 INFO - Running setup.py (path:/tmp/pip-dv8efo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:03 INFO - Running setup.py (path:/tmp/pip-RDy_d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:03 INFO - Running setup.py (path:/tmp/pip-pg9jE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:03 INFO - Running setup.py (path:/tmp/pip-p58gc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:03 INFO - Running setup.py (path:/tmp/pip-LqrtI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:03 INFO - Running setup.py (path:/tmp/pip-IYujcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:03 INFO - Running setup.py (path:/tmp/pip-pAfaDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:03 INFO - Running setup.py (path:/tmp/pip-HehLPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:04 INFO - Running setup.py (path:/tmp/pip-CRwAWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:04 INFO - Running setup.py (path:/tmp/pip-2FFXWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:04 INFO - Running setup.py (path:/tmp/pip-BnZGKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:04 INFO - Running setup.py (path:/tmp/pip-Pi0WpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:04 INFO - Running setup.py install for manifestparser 20:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:04 INFO - Running setup.py install for mozcrash 20:03:04 INFO - Running setup.py install for mozdebug 20:03:04 INFO - Running setup.py install for mozdevice 20:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:04 INFO - Running setup.py install for mozfile 20:03:04 INFO - Running setup.py install for mozhttpd 20:03:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:04 INFO - Running setup.py install for mozinfo 20:03:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for mozInstall 20:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for mozleak 20:03:05 INFO - Running setup.py install for mozlog 20:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for moznetwork 20:03:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for mozprocess 20:03:05 INFO - Running setup.py install for mozprofile 20:03:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for mozrunner 20:03:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:05 INFO - Running setup.py install for mozscreenshot 20:03:05 INFO - Running setup.py install for moztest 20:03:05 INFO - Running setup.py install for mozversion 20:03:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:03:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:03:06 INFO - Cleaning up... 20:03:06 INFO - Return code: 0 20:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:06 INFO - Using env: {'DISPLAY': ':0', 20:03:06 INFO - 'HOME': '/home/cltbld', 20:03:06 INFO - 'LANG': 'en_US.UTF-8', 20:03:06 INFO - 'LANGUAGE': 'en_US:en', 20:03:06 INFO - 'LOGNAME': 'cltbld', 20:03:06 INFO - 'MAIL': '/var/mail/cltbld', 20:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:06 INFO - 'MOZ_NO_REMOTE': '1', 20:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:06 INFO - 'NO_EM_RESTART': '1', 20:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:06 INFO - 'PWD': '/builds/slave/test', 20:03:06 INFO - 'SHELL': '/bin/bash', 20:03:06 INFO - 'SHLVL': '1', 20:03:06 INFO - 'TERM': 'linux', 20:03:06 INFO - 'TMOUT': '86400', 20:03:06 INFO - 'USER': 'cltbld', 20:03:06 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:06 INFO - '_': '/tools/buildbot/bin/python'} 20:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:06 INFO - Running setup.py (path:/tmp/pip-ZeTHv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:06 INFO - Running setup.py (path:/tmp/pip-wX3JcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:06 INFO - Running setup.py (path:/tmp/pip-7_74lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:06 INFO - Running setup.py (path:/tmp/pip-GHHJMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:06 INFO - Running setup.py (path:/tmp/pip-qBOUiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:06 INFO - Running setup.py (path:/tmp/pip-uKMdlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:06 INFO - Running setup.py (path:/tmp/pip-XG2n1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:06 INFO - Running setup.py (path:/tmp/pip-p44OHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:06 INFO - Running setup.py (path:/tmp/pip-sK2_kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:06 INFO - Running setup.py (path:/tmp/pip-8OoVKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:07 INFO - Running setup.py (path:/tmp/pip-aZ7G1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:07 INFO - Running setup.py (path:/tmp/pip-2_4I3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:07 INFO - Running setup.py (path:/tmp/pip-MUDxHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:07 INFO - Running setup.py (path:/tmp/pip-Eep_Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:07 INFO - Running setup.py (path:/tmp/pip-CLmIXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:07 INFO - Running setup.py (path:/tmp/pip-rYBQ4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:07 INFO - Running setup.py (path:/tmp/pip-cnhWNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:03:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:09 INFO - Downloading blessings-1.5.1.tar.gz 20:03:09 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:03:09 INFO - Installing collected packages: blessings 20:03:09 INFO - Running setup.py install for blessings 20:03:09 INFO - Successfully installed blessings 20:03:09 INFO - Cleaning up... 20:03:09 INFO - Return code: 0 20:03:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:09 INFO - Reading from file tmpfile_stdout 20:03:09 INFO - Current package versions: 20:03:09 INFO - argparse == 1.2.1 20:03:09 INFO - blessings == 1.5.1 20:03:09 INFO - blobuploader == 1.2.4 20:03:09 INFO - docopt == 0.6.1 20:03:09 INFO - manifestparser == 1.1 20:03:09 INFO - mozInstall == 1.12 20:03:09 INFO - mozcrash == 0.16 20:03:09 INFO - mozdebug == 0.1 20:03:09 INFO - mozdevice == 0.47 20:03:09 INFO - mozfile == 1.2 20:03:09 INFO - mozhttpd == 0.7 20:03:09 INFO - mozinfo == 0.9 20:03:09 INFO - mozleak == 0.1 20:03:09 INFO - mozlog == 3.1 20:03:09 INFO - moznetwork == 0.27 20:03:09 INFO - mozprocess == 0.22 20:03:09 INFO - mozprofile == 0.28 20:03:09 INFO - mozrunner == 6.11 20:03:09 INFO - mozscreenshot == 0.1 20:03:09 INFO - mozsystemmonitor == 0.0 20:03:09 INFO - moztest == 0.7 20:03:09 INFO - mozversion == 1.4 20:03:09 INFO - psutil == 3.1.1 20:03:09 INFO - requests == 1.2.3 20:03:09 INFO - wsgiref == 0.1.2 20:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:03:09 INFO - Using env: {'DISPLAY': ':0', 20:03:09 INFO - 'HOME': '/home/cltbld', 20:03:09 INFO - 'LANG': 'en_US.UTF-8', 20:03:09 INFO - 'LANGUAGE': 'en_US:en', 20:03:09 INFO - 'LOGNAME': 'cltbld', 20:03:09 INFO - 'MAIL': '/var/mail/cltbld', 20:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:09 INFO - 'MOZ_NO_REMOTE': '1', 20:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:09 INFO - 'NO_EM_RESTART': '1', 20:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:09 INFO - 'PWD': '/builds/slave/test', 20:03:09 INFO - 'SHELL': '/bin/bash', 20:03:09 INFO - 'SHLVL': '1', 20:03:09 INFO - 'TERM': 'linux', 20:03:09 INFO - 'TMOUT': '86400', 20:03:09 INFO - 'USER': 'cltbld', 20:03:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:09 INFO - '_': '/tools/buildbot/bin/python'} 20:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:03:09 INFO - Cleaning up... 20:03:09 INFO - Return code: 0 20:03:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:03:09 INFO - Using env: {'DISPLAY': ':0', 20:03:09 INFO - 'HOME': '/home/cltbld', 20:03:09 INFO - 'LANG': 'en_US.UTF-8', 20:03:09 INFO - 'LANGUAGE': 'en_US:en', 20:03:09 INFO - 'LOGNAME': 'cltbld', 20:03:09 INFO - 'MAIL': '/var/mail/cltbld', 20:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:09 INFO - 'MOZ_NO_REMOTE': '1', 20:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:09 INFO - 'NO_EM_RESTART': '1', 20:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:09 INFO - 'PWD': '/builds/slave/test', 20:03:09 INFO - 'SHELL': '/bin/bash', 20:03:09 INFO - 'SHLVL': '1', 20:03:09 INFO - 'TERM': 'linux', 20:03:09 INFO - 'TMOUT': '86400', 20:03:09 INFO - 'USER': 'cltbld', 20:03:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:09 INFO - '_': '/tools/buildbot/bin/python'} 20:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:10 INFO - Downloading/unpacking jsonschema 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:03:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:12 INFO - warning: no files found matching '*.txt' 20:03:12 INFO - no previously-included directories found matching 'build' 20:03:12 INFO - no previously-included directories found matching 'dist' 20:03:12 INFO - no previously-included directories found matching '.git*' 20:03:12 INFO - Installing collected packages: jsonschema, functools32 20:03:12 INFO - Running setup.py install for functools32 20:03:12 INFO - warning: no files found matching '*.txt' 20:03:12 INFO - no previously-included directories found matching 'build' 20:03:12 INFO - no previously-included directories found matching 'dist' 20:03:12 INFO - no previously-included directories found matching '.git*' 20:03:12 INFO - Successfully installed jsonschema functools32 20:03:12 INFO - Cleaning up... 20:03:12 INFO - Return code: 0 20:03:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f44c55e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d06dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:03:12 INFO - Using env: {'DISPLAY': ':0', 20:03:12 INFO - 'HOME': '/home/cltbld', 20:03:12 INFO - 'LANG': 'en_US.UTF-8', 20:03:12 INFO - 'LANGUAGE': 'en_US:en', 20:03:12 INFO - 'LOGNAME': 'cltbld', 20:03:12 INFO - 'MAIL': '/var/mail/cltbld', 20:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:12 INFO - 'MOZ_NO_REMOTE': '1', 20:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:12 INFO - 'NO_EM_RESTART': '1', 20:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:12 INFO - 'PWD': '/builds/slave/test', 20:03:12 INFO - 'SHELL': '/bin/bash', 20:03:12 INFO - 'SHLVL': '1', 20:03:12 INFO - 'TERM': 'linux', 20:03:12 INFO - 'TMOUT': '86400', 20:03:12 INFO - 'USER': 'cltbld', 20:03:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:12 INFO - '_': '/tools/buildbot/bin/python'} 20:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:12 INFO - Downloading/unpacking flake8 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:03:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:03:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:03:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:14 INFO - no previously-included directories found matching 'docs/_build' 20:03:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:03:15 INFO - Running setup.py install for pep8 20:03:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:03:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:03:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:03:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:03:15 INFO - no previously-included directories found matching 'docs/_build' 20:03:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:03:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:03:15 INFO - Cleaning up... 20:03:15 INFO - Return code: 0 20:03:15 INFO - Running post-action listener: _resource_record_post_action 20:03:15 INFO - Running post-action listener: _start_resource_monitoring 20:03:15 INFO - Starting resource monitoring. 20:03:15 INFO - ##### 20:03:15 INFO - ##### Running install step. 20:03:15 INFO - ##### 20:03:15 INFO - Running pre-action listener: _resource_record_pre_action 20:03:15 INFO - Running main action method: install 20:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:03:15 INFO - Reading from file tmpfile_stdout 20:03:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:03:15 INFO - Reading from file tmpfile_stdout 20:03:15 INFO - Output received: 20:03:15 INFO - Usage: mozinstall [options] installer 20:03:15 INFO - Options: 20:03:15 INFO - -h, --help show this help message and exit 20:03:15 INFO - -d DEST, --destination=DEST 20:03:15 INFO - Directory to install application into. [default: 20:03:15 INFO - "/builds/slave/test"] 20:03:15 INFO - --app=APP Application being installed. [default: firefox] 20:03:15 INFO - mkdir: /builds/slave/test/build/application 20:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:03:31 INFO - Reading from file tmpfile_stdout 20:03:31 INFO - Output received: 20:03:31 INFO - /builds/slave/test/build/application/firefox/firefox 20:03:31 INFO - Running post-action listener: _resource_record_post_action 20:03:31 INFO - ##### 20:03:31 INFO - ##### Running run-tests step. 20:03:31 INFO - ##### 20:03:31 INFO - Running pre-action listener: _resource_record_pre_action 20:03:31 INFO - Running main action method: run_tests 20:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:03:31 INFO - Python 2.7.3 20:03:31 INFO - Return code: 0 20:03:31 INFO - grabbing minidump binary from tooltool 20:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d993d0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:03:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:03:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:03:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:03:31 INFO - Return code: 0 20:03:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:03:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:03:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:03:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:03:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:03:32 INFO - Return code: 0 20:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:03:32 INFO - Using env: {'DISPLAY': ':0', 20:03:32 INFO - 'HOME': '/home/cltbld', 20:03:32 INFO - 'LANG': 'en_US.UTF-8', 20:03:32 INFO - 'LANGUAGE': 'en_US:en', 20:03:32 INFO - 'LOGNAME': 'cltbld', 20:03:32 INFO - 'MAIL': '/var/mail/cltbld', 20:03:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:03:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:32 INFO - 'MOZ_NO_REMOTE': '1', 20:03:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:32 INFO - 'NO_EM_RESTART': '1', 20:03:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:32 INFO - 'PWD': '/builds/slave/test', 20:03:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:03:32 INFO - 'SHELL': '/bin/bash', 20:03:32 INFO - 'SHLVL': '1', 20:03:32 INFO - 'TERM': 'linux', 20:03:32 INFO - 'TMOUT': '86400', 20:03:32 INFO - 'USER': 'cltbld', 20:03:32 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587', 20:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:32 INFO - '_': '/tools/buildbot/bin/python'} 20:03:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:03:32 INFO - mozversion application_buildid: 20160110193316 20:03:32 INFO - mozversion application_changeset: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 20:03:32 INFO - mozversion application_display_name: Nightly 20:03:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:03:32 INFO - mozversion application_name: Firefox 20:03:32 INFO - mozversion application_remotingname: firefox 20:03:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:03:32 INFO - mozversion application_vendor: Mozilla 20:03:32 INFO - mozversion application_version: 46.0a1 20:03:32 INFO - mozversion platform_buildid: 20160110193316 20:03:32 INFO - mozversion platform_changeset: 60a85952d9fdbd2740d6764aaf172735a37e1ca7 20:03:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:03:32 INFO - mozversion platform_version: 46.0a1 20:03:32 INFO - using testdate: 1452485012 20:03:32 INFO - actual date: 1452485012 20:03:32 INFO - starting webserver on 'localhost:49470' 20:03:32 INFO - SUITE-START | Running 3 tests 20:03:32 INFO - TEST-START | dromaeo_css 20:03:32 INFO - operating with platform_type : linux_ 20:03:32 INFO - Initialising browser for dromaeo_css test... 20:03:32 INFO - TEST-INFO | started process 4457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6unusd/profile http://localhost:49470/getInfo.html) 20:03:36 INFO - PROCESS | 4457 | __metrics Screen width/height:1600/1200 20:03:36 INFO - PROCESS | 4457 | colorDepth:24 20:03:36 INFO - PROCESS | 4457 | Browser inner width/height: 1024/697 20:03:36 INFO - PROCESS | 4457 | __metrics 20:03:37 INFO - PROCESS | 4457 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:03:37 INFO - PROCESS | 4457 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:03:38 INFO - TEST-INFO | 4457: exit 0 20:03:38 INFO - Browser initialized. 20:03:38 INFO - Running cycle 1/1 for dromaeo_css test... 20:03:38 INFO - TEST-INFO | started process 4550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6unusd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:03:50 INFO - PROCESS | 4550 | RSS: Main: 149258240 20:03:50 INFO - PROCESS | 4550 | 20:04:41 INFO - PROCESS | 4550 | 1452485081485 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:06:53 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49470/tests/dromaeo/cssquery-ext.html) 20:06:54 INFO - PROCESS | 4550 | RSS: Main: 292978688 20:06:54 INFO - PROCESS | 4550 | 20:09:57 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-ext.html (next: http://localhost:49470/tests/dromaeo/cssquery-jquery.html) 20:09:57 INFO - PROCESS | 4550 | RSS: Main: 226484224 20:09:57 INFO - PROCESS | 4550 | 20:12:59 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49470/tests/dromaeo/cssquery-mootools.html) 20:13:00 INFO - PROCESS | 4550 | RSS: Main: 230002688 20:13:00 INFO - PROCESS | 4550 | 20:16:02 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49470/tests/dromaeo/cssquery-prototype.html) 20:16:02 INFO - PROCESS | 4550 | RSS: Main: 210231296 20:16:02 INFO - PROCESS | 4550 | 20:19:05 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49470/tests/dromaeo/cssquery-yui.html) 20:19:06 INFO - PROCESS | 4550 | RSS: Main: 213155840 20:19:06 INFO - PROCESS | 4550 | 20:22:08 INFO - PROCESS | 4550 | Cycle 1(1): loaded http://localhost:49470/tests/dromaeo/cssquery-yui.html (next: http://localhost:49470/tests/dromaeo/cssquery-dojo.html) 20:22:09 INFO - PROCESS | 4550 | RSS: Main: 256966656 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | __start_tp_report 20:22:09 INFO - PROCESS | 4550 | _x_x_mozilla_page_load 20:22:09 INFO - PROCESS | 4550 | _x_x_mozilla_page_load_details 20:22:09 INFO - PROCESS | 4550 | |i|pagename|runs| 20:22:09 INFO - PROCESS | 4550 | |0;dojo.html;2561.6669832921725;2642.392249782551;2645.9603105953415;2660.9866950665246;2671.105179764779;4337.414449049377;4471.5081341052455;4491.3263010548435;4494.325851122333;4500.279955207164;4473.575010374017;4487.596116349528;4530.524294949032;4553.726776393419;4600.447946246447;4086.509618845728;4130.070734084829;4168.270552653274;4242.448481697391;4250.511191213003;3989.5412027616903;4191.937120943188;4225.68307376948;4255.553166917475;4275.230458517465;4113.382992551096;4117.876463706094;4136.090060186754;4226.640735537483;4243.257429949777;4201.033762234703;4222.767747773872;4223.809928553223;4225.345071513921;4259.8083086261195;4192.874213773592;4208.473940757405;4216.451861258048;4236.745795252264;4245.532991370947;4283.593058659453;4336.457942757155;4383.736975781431;4412.24991751403;4432.468103827561;4796.832110876103;4798.232282834764;4802.447718512381;4815;4839.7096174229655;4812.614990800727;4816.710997340171;4821.710697358169;4822.855314340575;4831.347768051303;4289.463817022904;4392.516823149451;4395.099004704028;4471.7987690554;4506.774661266923;4915.4347250065985;4922.040202160544;4933.777979990909;4933.802647894116;4960.330355401975;4736.289556566542;4745.145873742759;4748.6438517111355;4750.809967601326;4793.880152996203;4692;4728.290756386569;4801.375821143229;4801.903961920742;4820.469748327681;4779.713217206979;4802.711837289774;4808.3027960945465;4809.422869255712;4821.373221481185;4784.880377990578;4791.784369703371;4798.1123492153365;4800.3279540864305;4802.639802014863;3983.3029219886403;4085.836566537365;4133.627973482341;4133.937990930139;4137.689673274516;3565.1800085979853;3597.2086141048926;3606.1886075633297;3621.4386770050683;3658.70730341572;4192.790360481964;4198.475190601175;4200.474940632421;4216.494020717533;4239.576042395797;4657.510961349078;4834.20235661112;4865.367502224759;4876.390451193601;4927.9507204927495;4036.858709945138;4045.959540404617;4047.9392809107885;4109.835606575763;4194.3708443733685;4311.611954924072;4326.978365108154;4337.869863904025;4342.913141737147;4379.211741886491;4610.930836037395;4615.446146462446;4622.14490319292;4624.78966914572;4634.096351211549;4584.908301834012;4701.435827700698;4703.74129422885;4768.976155119202;4866.416030076413;4639.373684552677;4652.790624421977;4653.1391692535635;4684;4695.694779839299;4795.760211989456;4807.062622788522;4816.133096042606;4817.8313759018265;4851.393575803025;4638.605718513964;4771.5467030632035;4773.164696178224;4775.403074615673;4849.757512124309;4616.422947131608;4618.284165954283;4649.790759415767;4664.253719404879;4666.393368862026;4630.398048253705;4659.813607455664;4771.64212684057;4773.284007398918;4781.7609119543185;4561.2473941799235;4569.063342014945;4583.977080114578;4585.403897493305;4596.3565100885235;4668.5564871337165;4669.066186762729;4674.158651442773;4681.297805329228;4717.2216584263215;4367.45406824147;4477.238869392277;4479.641628669764;4575.450945886515;4691.483936766885 20:22:09 INFO - PROCESS | 4550 | |1;ext.html;490.65899200055964;493.1517789402227;495.7124867576806;496.4836569967234;530.6418167736776;24990.37524061897;32682;33180.5022924656;33318.33363332732;33335.16662083449;36085.278294434094;36534.45198322027;36564;36606;36607.816960915225;6773.153355830521;6899;7522.285382888617;7711.652975616083;7716.922830771705;9460.479673617949;9681.177099946513;9695.418274903494;9704.854427183598;9705.757356066084;9669.758256043584;9775.462349570771;9778.462184579845;9781.657641982532;9784.217262618973;9512.286578506604;9651.372660777097;9673.467959262238;9677.274204434696;9680.515974201333;9519.333646644738;9672.75818104546;9680.56437460309;9919.206463482904;10008.149307308888;37211.81394093012;37583.81208093942;37610.43584346237;37665.3501974706;37674.43488347677;2894.82631042136;2954.3500429905384;2959.3489432324855;3377.1800546543664;3571.8727458149992;28878.71121288781;28894.566581501294;28953;28987.56518652222;29188.854055729586;3373.1567108222944;3384.881529146468;3393.2704468539137;3442.1050526862946;3486.459598762196;213303;215293.92353038292;215394;215840;216492;44856;45828;54021.72989135029;54597;55162.448375516535;45881.311780323325;46113.53886461093;46249;46486;46631.766841165576;13613.11514751538;13825.930870345584;13832.654183645289;13841.169529828243;13845.584632460841;9672.274579406572;9684.95157524208;9685.854712179324;9695.951520242495;9789.118979291898;18128.365507207185;18497.260109595736;18500.629987400447;18516.259349626132;18574.81425185758;6924;7163.42692584592;7242.855142897218;7247.275272472816;7351.852962940711;860.8665656823202;877.2455688108222;901.7970956534728;1004.5680357446222;1049.6693541534391;25608.743912560636;25712.12000319159;25730;25910.611340829902;26209;932.5337331334333;959.3332633819429;971.7910649210312;1007.4005966449951;1035.1822060572063;12134.635960921187;12201.633950981484;12225.44985475638;12263.693407664701;12283;257756;260262;260515;260686;262108;43921.34117988233;44118.558814411444;44158.55841441544;44172.55827441749;44177;1210.5278941212935;1233.734747029375;1241.5344245907784;1249.09440655524;1255.918365306252;20680;25817.354566135997;25944.06572976452;26313.73686263113;26593.202203933914;39251;39642;39643;39693.60306397015;39706.40440393339;164265.17867411065;164712;164837;165330;165563;23842.523149536566;24313.270601881974;27230;27597.31006724848;28137;32150.83924580362;32442.675573243967;32648.51027234546;32899.50650740193;33342.83328583342;28160.85919570389;28414.57378139371;28554.571681425212;28675.713242867303;29278.7072129276;24311.63532546978;27961.580576291777;28490.287742805765;31266.11520977664;32213.677863221066;29820.701792981792;30591.847040764653;30898.382032359677;30937.215650590653;30970.070897873098;25661;29305.706942930297;30111.548326775555;30224.5466318001;30366.240843979078;21187.152513899273;22239.66640500426;22303;22468;22510.774892251524 20:22:09 INFO - PROCESS | 4550 | |2;jquery.html;323.5648053368219;330.39042965728237;330.94208513510137;335.50177985691244;339.4162041288985;12000.219985700945;12464.81302780459;14607.342669579868;14736.336864841094;14996.625084372883;12761.61715148547;13654;15431.228438578082;15641;15661.686766264667;4774.928376074353;5060.4686507916695;5066.341375621164;5067.822626208065;5069.44236134025;3716.3310604091253;3840.9807950960208;4882.9511704883025;4961.603071754251;4965.255211718235;5673.404292549285;5895.056790913454;5911.556633252501;5924.170616113726;5937.4656280934705;5650.943490565083;5715.199872017921;5719.48524632785;5727.055035919089;5740.684262365568;4788.856334309976;4948.208286674151;4971.4282857471135;5034.144195486776;5050.595952323805;18037.819621803745;18144.637107257782;18392.356267530573;18399.448016559523;18615.162317695736;578.8871170121828;580.886727088218;581.8516278349036;1906.8474522038205;1956.833669138125;11786.292822430596;11885.22746021506;11968.940155299255;12205.633830985085;12497.93751031248;1770.5750619851271;1779.8665100117414;1782.857371410284;1824.6350729854082;1853.7775466943917;44088.11823763507;47364.52635473636;47746;47928.76035619834;48564.75717621425;8809.33929955256;8999.235065019546;9101.317401194938;9101.453912765255;9112.225460835904;11647.41762911868;11656.941715291368;11672.766544669059;11680.123990700562;11691.298522088531;6106.832074613537;6464;6599.637019963948;6651.567648102858;6750;6400.935990640127;6503.382178693017;6558.8360290993105;6605.1083103780375;6619.3380661933425;3983.063979964706;4068.044009657728;4070.1452694933805;4100.1184745279315;4119.7940102994735;1604.8555629993357;1645.12808211648;1645.5886028492878;1648.4395305596154;1696.711559034967;382.95213098362706;800.3757069485811;812.7155495576501;922.8846394200725;928.3872644054892;9252.7686807829;9444.95277523608;9606.903930960601;9712.02879712023;9785;394.2627286973378;402.8831638824708;403.1655965357611;405.9431679564863;417.98328066877593;5123.0522353364;5157.819476318386;5295.761690723926;5399.460053994648;5463.153211252262;402893.7829662787;403270;426168;429049;431120;64319.71360572762;65099.349006510274;65596;65873.67063164653;66613.66693166504;982.9017098290113;1024.8923862994427;1029.2023681646783;1031.2471895516314;1049.9580016799243;13718.93140534291;14008.649783755487;14225.857741422868;14298.499552515612;14449.277536123362;19497.02514874279;19958;28331.291717707223;29670.961516346822;31464.842675786476;39590.802045989585;40347;40468.595314046484;40575.59424405836;40630.1873962525;6364;6582.432851187945;6599.472042236705;6890.276520965226;6914.0320355149315;9089.727308180765;9852.113309802153;9867.161291290033;9900.801983960137;9983.201343892326;7753.651085701044;8047.356211502949;8181;8323.500589964622;8402.41183117176;8366.163383661586;8439.156084391512;8755.299576033774;9176.495292758962;9555.569999350186;8414.915850841413;8503.914960850312;8589.82820343577;8598.269147122564;8976.102389761232;5116.181410974226;6279.340669229665;6799.490038247052;6810.31896810315;7003.509754317352;6903.689333980084;8389.454685445426;8556.401051926305;8579.699710510102;8681.8697719533 20:22:09 INFO - PROCESS | 4550 | |3;mootools.html;1423.9288035598217;1442.747519184143;1586.5002524204874;1750.9912450437746;1780.187304059586;6461.70922308496;6640.933590664092;7113.075300210971;7269.382102521286;7270.454715896309;6907.792766217009;7025.227225005258;7082.397996170319;7084.043654106694;7088.432925365972;2070.8446866484996;2097.947551311222;2098.1607357057146;2102.3692892132376;2102.4008157675066;1793.2468363287385;1835.5869929265941;2065.5559054803216;2118.8093071623553;2130.1798807459086;2103.9894800525976;2118.163325486432;2127.7446706395253;2131.211451762842;2131.3073251193346;2090.341542414142;2114.7356580427445;2118.9788102118937;2119.4171602809197;2122.7877212278804;2089.529855782452;2104.1057550541113;2122.7877212278804;2137.6045431595203;2140.4541841830387;7666.846663066707;7683.57740324282;7742.303192712627;7742.341900938427;7748.147703752583;4317.805698743564;4433.002574420761;4448.33275008748;4465.508794032654;4466.731996080213;2820.6333176687103;2849.2734352740126;2854.6717127530183;2883.9134825955043;2910.432465669195;941.9811603767886;947.5925352098595;966.7728083900278;976.6776963601994;1018.9388636681749;10759.139268858473;10789.136869050535;10792.028717415391;10798.136149108053;10804.297720648132;3913.92172156561;4028.1742242840146;4032.919341613151;4050.858219962287;4108.650764684976;9192.17270445663;9192.908070919339;9203.815923681488;9207.355485115977;9213.63145474187;4404.889877753082;4412.139632771578;4420.071784925138;4447.132809102259;4454.888627784267;3966.4729079304675;3998.1803730235233;4000.7999600019884;4001.9399709004388;4005.1989602079702;3420.9828950855585;3540.345036168317;3551.5738111426795;3556.3065202285306;3560.3235385276716;946.4652471353663;1000.309786247487;1086.2342048855537;1103.1230172013268;1109.9278546894589;1163.1044096046166;1169.7601991591703;1184.1592469346688;1185.7315646501258;1204.6867814368152;7178.2103968563415;7268;7315.085614298213;7345.118585769742;7372.078490188726;1052.1372474570778;1064.7763969566322;1072.1637123044038;1080.2384319055047;1080.6163811846839;5506.063969125258;5619.80330688424;5631.2397826293745;5633.549316054706;5635.098384258499;9041.141091596288;9327.720168394959;9353.625854965725;9501.382410143457;9601.183899368632;9311.627534898527;9383.859242111374;9461.621535138518;9463.337566370288;9513.904860951441;7026.789196324118;7149.678264478111;7316.670749816271;7319.926800732031;7336.926630733731;6920.550164239308;6977.965110174417;6982.79051628452;6994.61529615876;7015.824604384727;8092.312153466786;8293.087760346478;8301.211384918422;8521.616527256412;8529.786755331166;8452.239298463168;8640.870386944327;8706.216440520384;8734.82530349402;8771.692990745549;6708.228553716385;6710.530262881747;6746.291639377795;6778.220504641832;6797.150356205474;6000.849978750566;7321.304476074764;7369.557826530426;7372.778816635509;7405;5634.526544628208;6085.6348619083;6175.814725558061;6707.4969377297875;6798.048273241849;6419.197600299963;6468.450181734605;6517.283098859217;6540.705668244846;6616.2722100567935;6713.966430167818;6795.048693182859;6795.082663840319;6796.116504854337;6814.318568143146;5899.557533184942;6100.6949652516305;6102.786402475892;6119.632822030692;6137.079438084323;6330.715117819617;6371.076193951943;6375.107484952017;6388.840278993062;6394.0408938659575 20:22:09 INFO - PROCESS | 4550 | |4;prototype.html;314.50151509856875;318.087090051552;320.6104582931736;322.3247296912968;324.8164786895404;5169.483051694829;5284.947150528494;5325.414204437514;5351.357837059559;5358.2766326546;5234.476552344764;5238.8690282742855;5239.79040838366;5247.055530004607;5248.47515248475;3919.314120028998;3958.168784555247;4000.0599859033105;4108.4248205251215;4111.1366613011305;4059.654929330996;4069.7965101744944;4075.8369665213504;4075.9388609170887;4086.795660216992;4027.3556231003045;4034.778087205217;4050.7772072536;4058.9188216235657;4060.654844338235;3843.3082045231845;3932.429797679349;3954;4033.4353190553347;4040.8181631826637;3594;3594.802285874276;3607.026102952188;3611.8916432507067;3612.6387361263664;5026.145555255579;5028.522290382444;5031;5033.219850923113;5040.319556859814;4663.207254766698;4678.087772884289;4681.648876334289;4687.062587482517;4694.859154225379;5355.571554275688;5479.123340265578;5484.91772623411;5484.91772623411;5493.478119578634;3912.68698504119;3916.314644937153;3919.510061242345;3923.941140882889;3923.98038009811;5770.307563092456;5773.711314434304;5779.306483221998;5781.71091445426;5792.710364481759;4021.698372622065;4041.878743637637;4044.8988775280263;4047.696422768245;4052.412400202013;3852.903677408031;3907.8632247871187;4106.199291138199;4108.383742438658;4108.4453598764385;4556.225441674923;4631.976840115778;4643.466001409881;4644.419447569054;4646.581807637262;5465.207544905967;5515.227868098469;5522.199281104217;5523.061079616475;5525.723713814293;1453.7383271011108;1470.6838029823639;1471.8748906342867;1472.1976522795103;1472.2197235465221;1014.2899970021015;1015.9847602285971;1021.6015753856002;1030.5465595138114;1035.2856528994969;4839.903201935942;4847.224444088929;4852.4662287148385;4853.6602437829015;4856.562909338177;5714.114312281603;5717.485426311652;5721.599488035798;5726.4273572642405;5729.28383952006;4846.733429661403;4852.539008794159;4852.805887764521;4853.878653033702;4855.174620314555;2985.6566494852937;3051.9237019074258;3084.8303343315883;3085.460044492205;3085.8302793346134;5466.508014278734;5475.890482190334;5487.533559647395;5492.670439773627;5498.780048798083;5929.911051334234;5935.2877654681715;5938.554608404387;5943.673097979567;5946.10808378738;5481.232627432242;5488.725563721798;5493.505584497414;5493.725313734298;5498.5876059295715;5633.126865335879;5764.423557644202;5778.27771528559;5786.045302525036;5789.973509271721;5655.688937108499;5656.88686226265;5660.9150862737915;5660.971695141663;5664.603477756517;5487.972560137174;5497.917531236954;5522.751476183662;5553.389127196086;5555.055640541199;3959.8218080185884;4000.9199816004098;4002.0795217100813;4043.1711499143194;4048.473698419187;5542.808296216333;5684.232628595087;5759.596828222152;5765.308163020297;5777.62445441045;5405.189221616789;5503.587230957774;5516.117421212587;5518.2826232589505;5552.666839989613;5541.667499950016;5542.5565954722715;5544;5546.75039623226;5549.7780088796;5327.3074500314715;5438.700871452108;5441.102218134122;5443.537299329601;5445.83662490126;5579.079451890392;5580.135079062752;5588.944110558842;5589.524890384363;5590.9440905592055;5439.646422982493;5454.127339625641;5459.672419654833;5462.262594549844;5478.150886612581 20:22:09 INFO - PROCESS | 4550 | |5;yui.html;710.8151880511066;740.4150720930465;747.558940225267;761.3642608421967;781.4178437064388;10820.78358432832;10964.780704385908;10964.835527467094;10965.725856853584;10969.670909872697;11112.555497780078;11112.722181945455;11119.221654484189;11164.330140191594;11181.83227251592;600.6126048698587;607.3380015782795;754.366332280884;770.7841804294807;770.9113451953041;784.0630446616295;785.9960700196491;787.3543694170754;789.1043665439738;790.6442101054548;827.3009307135461;827.8096037911254;828.7596596986866;829.1832544943226;830.0703212402118;636.3541005879036;646.8027251688234;812.0417906869891;827.6730691376872;829.2081062585216;611.5199568338877;611.5627326461557;611.6544152553837;611.6972098811073;611.721666641677;11393.772124557463;11427.371494567795;11449;11467.598634047768;11474.426278686033;10589.364638121737;10838;11003.724906877393;11198.720031999184;11229.045531129783;9130.634774609007;9250.028746981538;9256.537173141383;9270.675526356612;9541.141297283279;3233.3371658810124;3248.561444205049;3293.4236508610898;3312.2381852174135;3315.8010519368913;37293.627063729284;37294.25411491755;37318.25363492742;37401.438978415346;37442.25115497702;9477.810443791224;9591.280653950982;9622.855657165148;9683.031696830401;9742.512874356396;16766.07786571726;16767.664646707;16791.32834686599;16794.58013549671;16811.495655130366;6613.338666133444;6636.502262330345;6641.136652235178;6695.899561506581;6820.522563420612;3722.6970560304217;3763.9623603764157;3811.5045044144085;3815.42768584709;3830.9808450957566;2503.7871780898827;2534.9873250633627;2540.6697129373065;2543.6438898554215;2547.50323686883;451.9344695019204;453.5509845253176;462.20039331955235;469.36635542018684;469.84729962761554;495.81040210223756;501.1280372152501;540.7269328988835;589.5195415736247;649.9025146228104;6658.300878407795;6679.833004174934;6777.695003724844;7668.693252269847;7863.37093032556;497.8474830766763;505.53490788474693;539.6600141910571;607.9148919151322;651.4267444648679;3768.4347347898033;3894.299026175259;3973.543042550086;4017.4777278953547;4045.089854782709;45010;45927.31109033367;45991;46029;46178.53821461809;40687.79656101701;41128.38307425331;41202.58797411987;41406.79296603498;42077.57922420798;37103.4434483483;37142.8142859284;37741.62258377381;37814;38863.22273554513;7802.375809935305;8061.556614386265;8254.257116859511;8287.83424331498;8582.699605513777;31049.223769405944;31357.84321078471;31940.201494961882;33141.337173256885;33898.66101338955;41042;41122.794386027876;41429;42468.362974556025;42533.57466425296;10225.43760093202;10256.487175641338;10529.736756581147;10608.204384671335;10717.517711703147;10835.620753273597;10976.396298203676;11061.079199908549;11130.16523760705;11497.367644779617;10435.37387756737;10483.423411712429;10723.731906702395;10736.570537178426;10931.289466184673;10564.683059508227;10569.841452378067;10604.946975265382;10639.574417023232;10805.351678899291;10096.293259471766;10147.79704405893;10162.74593135148;10225.74435639115;10426.843597345895;8480.533570653426;8930.598123084606;9017.278617710435;9169.495677737788;9393.624255029723;9032.277417806692;9288.814223715623;9331.113544213289;9408.623655053721;9455.574499147693 20:22:09 INFO - PROCESS | 4550 | __end_tp_report 20:22:09 INFO - PROCESS | 4550 | __start_cc_report 20:22:09 INFO - PROCESS | 4550 | _x_x_mozilla_cycle_collect,1223 20:22:09 INFO - PROCESS | 4550 | __end_cc_report 20:22:09 INFO - PROCESS | 4550 | __startTimestamp1452486129128__endTimestamp 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | ------- Summary: start ------- 20:22:09 INFO - PROCESS | 4550 | Number of tests: 6 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#0] dojo.html Cycles:165 Average:4453.96 Median:4585.40 stddev:441.98 (9.6%) stddev-sans-first:417.67 20:22:09 INFO - PROCESS | 4550 | Values: 2561.7 2642.4 2646.0 2661.0 2671.1 4337.4 4471.5 4491.3 4494.3 4500.3 4473.6 4487.6 4530.5 4553.7 4600.4 4086.5 4130.1 4168.3 4242.4 4250.5 3989.5 4191.9 4225.7 4255.6 4275.2 4113.4 4117.9 4136.1 4226.6 4243.3 4201.0 4222.8 4223.8 4225.3 4259.8 4192.9 4208.5 4216.5 4236.7 4245.5 4283.6 4336.5 4383.7 4412.2 4432.5 4796.8 4798.2 4802.4 4815.0 4839.7 4812.6 4816.7 4821.7 4822.9 4831.3 4289.5 4392.5 4395.1 4471.8 4506.8 4915.4 4922.0 4933.8 4933.8 4960.3 4736.3 4745.1 4748.6 4750.8 4793.9 4692.0 4728.3 4801.4 4801.9 4820.5 4779.7 4802.7 4808.3 4809.4 4821.4 4784.9 4791.8 4798.1 4800.3 4802.6 3983.3 4085.8 4133.6 4133.9 4137.7 3565.2 3597.2 3606.2 3621.4 3658.7 4192.8 4198.5 4200.5 4216.5 4239.6 4657.5 4834.2 4865.4 4876.4 4928.0 4036.9 4046.0 4047.9 4109.8 4194.4 4311.6 4327.0 4337.9 4342.9 4379.2 4610.9 4615.4 4622.1 4624.8 4634.1 4584.9 4701.4 4703.7 4769.0 4866.4 4639.4 4652.8 4653.1 4684.0 4695.7 4795.8 4807.1 4816.1 4817.8 4851.4 4638.6 4771.5 4773.2 4775.4 4849.8 4616.4 4618.3 4649.8 4664.3 4666.4 4630.4 4659.8 4771.6 4773.3 4781.8 4561.2 4569.1 4584.0 4585.4 4596.4 4668.6 4669.1 4674.2 4681.3 4717.2 4367.5 4477.2 4479.6 4575.5 4691.5 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#1] ext.html Cycles:180 Average:36743.33 Median:32545.59 stddev:56384.26 (173.2%) stddev-sans-first:56476.73 20:22:09 INFO - PROCESS | 4550 | Values: 490.7 493.2 495.7 496.5 530.6 24990.4 32682.0 33180.5 33318.3 33335.2 36085.3 36534.5 36564.0 36606.0 36607.8 6773.2 6899.0 7522.3 7711.7 7716.9 9460.5 9681.2 9695.4 9704.9 9705.8 9669.8 9775.5 9778.5 9781.7 9784.2 9512.3 9651.4 9673.5 9677.3 9680.5 9519.3 9672.8 9680.6 9919.2 10008.1 37211.8 37583.8 37610.4 37665.4 37674.4 2894.8 2954.4 2959.3 3377.2 3571.9 28878.7 28894.6 28953.0 28987.6 29188.9 3373.2 3384.9 3393.3 3442.1 3486.5 213303.0 215293.9 215394.0 215840.0 216492.0 44856.0 45828.0 54021.7 54597.0 55162.4 45881.3 46113.5 46249.0 46486.0 46631.8 13613.1 13825.9 13832.7 13841.2 13845.6 9672.3 9685.0 9685.9 9696.0 9789.1 18128.4 18497.3 18500.6 18516.3 18574.8 6924.0 7163.4 7242.9 7247.3 7351.9 860.9 877.2 901.8 1004.6 1049.7 25608.7 25712.1 25730.0 25910.6 26209.0 932.5 959.3 971.8 1007.4 1035.2 12134.6 12201.6 12225.4 12263.7 12283.0 257756.0 260262.0 260515.0 260686.0 262108.0 43921.3 44118.6 44158.6 44172.6 44177.0 1210.5 1233.7 1241.5 1249.1 1255.9 20680.0 25817.4 25944.1 26313.7 26593.2 39251.0 39642.0 39643.0 39693.6 39706.4 164265.2 164712.0 164837.0 165330.0 165563.0 23842.5 24313.3 27230.0 27597.3 28137.0 32150.8 32442.7 32648.5 32899.5 33342.8 28160.9 28414.6 28554.6 28675.7 29278.7 24311.6 27961.6 28490.3 31266.1 32213.7 29820.7 30591.8 30898.4 30937.2 30970.1 25661.0 29305.7 30111.5 30224.5 30366.2 21187.2 22239.7 22303.0 22468.0 22510.8 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#2] jquery.html Cycles:180 Average:22572.12 Median:5002.79 stddev:68490.23 (1369.0%) stddev-sans-first:68661.99 20:22:09 INFO - PROCESS | 4550 | Values: 323.6 330.4 330.9 335.5 339.4 12000.2 12464.8 14607.3 14736.3 14996.6 12761.6 13654.0 15431.2 15641.0 15661.7 4774.9 5060.5 5066.3 5067.8 5069.4 3716.3 3841.0 4883.0 4961.6 4965.3 5673.4 5895.1 5911.6 5924.2 5937.5 5650.9 5715.2 5719.5 5727.1 5740.7 4788.9 4948.2 4971.4 5034.1 5050.6 18037.8 18144.6 18392.4 18399.4 18615.2 578.9 580.9 581.9 1906.8 1956.8 11786.3 11885.2 11968.9 12205.6 12497.9 1770.6 1779.9 1782.9 1824.6 1853.8 44088.1 47364.5 47746.0 47928.8 48564.8 8809.3 8999.2 9101.3 9101.5 9112.2 11647.4 11656.9 11672.8 11680.1 11691.3 6106.8 6464.0 6599.6 6651.6 6750.0 6400.9 6503.4 6558.8 6605.1 6619.3 3983.1 4068.0 4070.1 4100.1 4119.8 1604.9 1645.1 1645.6 1648.4 1696.7 383.0 800.4 812.7 922.9 928.4 9252.8 9445.0 9606.9 9712.0 9785.0 394.3 402.9 403.2 405.9 418.0 5123.1 5157.8 5295.8 5399.5 5463.2 402893.8 403270.0 426168.0 429049.0 431120.0 64319.7 65099.3 65596.0 65873.7 66613.7 982.9 1024.9 1029.2 1031.2 1050.0 13718.9 14008.6 14225.9 14298.5 14449.3 19497.0 19958.0 28331.3 29671.0 31464.8 39590.8 40347.0 40468.6 40575.6 40630.2 6364.0 6582.4 6599.5 6890.3 6914.0 9089.7 9852.1 9867.2 9900.8 9983.2 7753.7 8047.4 8181.0 8323.5 8402.4 8366.2 8439.2 8755.3 9176.5 9555.6 8414.9 8503.9 8589.8 8598.3 8976.1 5116.2 6279.3 6799.5 6810.3 7003.5 6903.7 8389.5 8556.4 8579.7 8681.9 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#3] mootools.html Cycles:180 Average:5278.83 Median:6111.21 stddev:2821.88 (46.2%) stddev-sans-first:2814.92 20:22:09 INFO - PROCESS | 4550 | Values: 1423.9 1442.7 1586.5 1751.0 1780.2 6461.7 6640.9 7113.1 7269.4 7270.5 6907.8 7025.2 7082.4 7084.0 7088.4 2070.8 2097.9 2098.2 2102.4 2102.4 1793.2 1835.6 2065.6 2118.8 2130.2 2104.0 2118.2 2127.7 2131.2 2131.3 2090.3 2114.7 2119.0 2119.4 2122.8 2089.5 2104.1 2122.8 2137.6 2140.5 7666.8 7683.6 7742.3 7742.3 7748.1 4317.8 4433.0 4448.3 4465.5 4466.7 2820.6 2849.3 2854.7 2883.9 2910.4 942.0 947.6 966.8 976.7 1018.9 10759.1 10789.1 10792.0 10798.1 10804.3 3913.9 4028.2 4032.9 4050.9 4108.7 9192.2 9192.9 9203.8 9207.4 9213.6 4404.9 4412.1 4420.1 4447.1 4454.9 3966.5 3998.2 4000.8 4001.9 4005.2 3421.0 3540.3 3551.6 3556.3 3560.3 946.5 1000.3 1086.2 1103.1 1109.9 1163.1 1169.8 1184.2 1185.7 1204.7 7178.2 7268.0 7315.1 7345.1 7372.1 1052.1 1064.8 1072.2 1080.2 1080.6 5506.1 5619.8 5631.2 5633.5 5635.1 9041.1 9327.7 9353.6 9501.4 9601.2 9311.6 9383.9 9461.6 9463.3 9513.9 7026.8 7149.7 7316.7 7319.9 7336.9 6920.6 6978.0 6982.8 6994.6 7015.8 8092.3 8293.1 8301.2 8521.6 8529.8 8452.2 8640.9 8706.2 8734.8 8771.7 6708.2 6710.5 6746.3 6778.2 6797.2 6000.8 7321.3 7369.6 7372.8 7405.0 5634.5 6085.6 6175.8 6707.5 6798.0 6419.2 6468.5 6517.3 6540.7 6616.3 6714.0 6795.0 6795.1 6796.1 6814.3 5899.6 6100.7 6102.8 6119.6 6137.1 6330.7 6371.1 6375.1 6388.8 6394.0 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#4] prototype.html Cycles:180 Average:4602.10 Median:5201.98 stddev:1342.66 (25.8%) stddev-sans-first:1307.29 20:22:09 INFO - PROCESS | 4550 | Values: 314.5 318.1 320.6 322.3 324.8 5169.5 5284.9 5325.4 5351.4 5358.3 5234.5 5238.9 5239.8 5247.1 5248.5 3919.3 3958.2 4000.1 4108.4 4111.1 4059.7 4069.8 4075.8 4075.9 4086.8 4027.4 4034.8 4050.8 4058.9 4060.7 3843.3 3932.4 3954.0 4033.4 4040.8 3594.0 3594.8 3607.0 3611.9 3612.6 5026.1 5028.5 5031.0 5033.2 5040.3 4663.2 4678.1 4681.6 4687.1 4694.9 5355.6 5479.1 5484.9 5484.9 5493.5 3912.7 3916.3 3919.5 3923.9 3924.0 5770.3 5773.7 5779.3 5781.7 5792.7 4021.7 4041.9 4044.9 4047.7 4052.4 3852.9 3907.9 4106.2 4108.4 4108.4 4556.2 4632.0 4643.5 4644.4 4646.6 5465.2 5515.2 5522.2 5523.1 5525.7 1453.7 1470.7 1471.9 1472.2 1472.2 1014.3 1016.0 1021.6 1030.5 1035.3 4839.9 4847.2 4852.5 4853.7 4856.6 5714.1 5717.5 5721.6 5726.4 5729.3 4846.7 4852.5 4852.8 4853.9 4855.2 2985.7 3051.9 3084.8 3085.5 3085.8 5466.5 5475.9 5487.5 5492.7 5498.8 5929.9 5935.3 5938.6 5943.7 5946.1 5481.2 5488.7 5493.5 5493.7 5498.6 5633.1 5764.4 5778.3 5786.0 5790.0 5655.7 5656.9 5660.9 5661.0 5664.6 5488.0 5497.9 5522.8 5553.4 5555.1 3959.8 4000.9 4002.1 4043.2 4048.5 5542.8 5684.2 5759.6 5765.3 5777.6 5405.2 5503.6 5516.1 5518.3 5552.7 5541.7 5542.6 5544.0 5546.8 5549.8 5327.3 5438.7 5441.1 5443.5 5445.8 5579.1 5580.1 5588.9 5589.5 5590.9 5439.6 5454.1 5459.7 5462.3 5478.2 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - PROCESS | 4550 | [#5] yui.html Cycles:180 Average:11925.92 Median:41417.90 stddev:13150.25 (31.8%) stddev-sans-first:13160.17 20:22:09 INFO - PROCESS | 4550 | Values: 710.8 740.4 747.6 761.4 781.4 10820.8 10964.8 10964.8 10965.7 10969.7 11112.6 11112.7 11119.2 11164.3 11181.8 600.6 607.3 754.4 770.8 770.9 784.1 786.0 787.4 789.1 790.6 827.3 827.8 828.8 829.2 830.1 636.4 646.8 812.0 827.7 829.2 611.5 611.6 611.7 611.7 611.7 11393.8 11427.4 11449.0 11467.6 11474.4 10589.4 10838.0 11003.7 11198.7 11229.0 9130.6 9250.0 9256.5 9270.7 9541.1 3233.3 3248.6 3293.4 3312.2 3315.8 37293.6 37294.3 37318.3 37401.4 37442.3 9477.8 9591.3 9622.9 9683.0 9742.5 16766.1 16767.7 16791.3 16794.6 16811.5 6613.3 6636.5 6641.1 6695.9 6820.5 3722.7 3764.0 3811.5 3815.4 3831.0 2503.8 2535.0 2540.7 2543.6 2547.5 451.9 453.6 462.2 469.4 469.8 495.8 501.1 540.7 589.5 649.9 6658.3 6679.8 6777.7 7668.7 7863.4 497.8 505.5 539.7 607.9 651.4 3768.4 3894.3 3973.5 4017.5 4045.1 45010.0 45927.3 45991.0 46029.0 46178.5 40687.8 41128.4 41202.6 41406.8 42077.6 37103.4 37142.8 37741.6 37814.0 38863.2 7802.4 8061.6 8254.3 8287.8 8582.7 31049.2 31357.8 31940.2 33141.3 33898.7 41042.0 41122.8 41429.0 42468.4 42533.6 10225.4 10256.5 10529.7 10608.2 10717.5 10835.6 10976.4 11061.1 11130.2 11497.4 10435.4 10483.4 10723.7 10736.6 10931.3 10564.7 10569.8 10604.9 10639.6 10805.4 10096.3 10147.8 10162.7 10225.7 10426.8 8480.5 8930.6 9017.3 9169.5 9393.6 9032.3 9288.8 9331.1 9408.6 9455.6 20:22:09 INFO - PROCESS | 4550 | -------- Summary: end -------- 20:22:09 INFO - PROCESS | 4550 | 20:22:09 INFO - TEST-INFO | 4550: exit 0 20:22:09 INFO - TEST-OK | dromaeo_css | took 1117371ms 20:22:09 INFO - TEST-START | kraken 20:22:09 INFO - operating with platform_type : linux_ 20:22:09 INFO - Initialising browser for kraken test... 20:22:09 INFO - TEST-INFO | started process 4747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FGUuV/profile http://localhost:49470/getInfo.html) 20:22:14 INFO - PROCESS | 4747 | __metrics Screen width/height:1600/1200 20:22:14 INFO - PROCESS | 4747 | colorDepth:24 20:22:14 INFO - PROCESS | 4747 | Browser inner width/height: 1024/697 20:22:14 INFO - PROCESS | 4747 | __metrics 20:22:14 INFO - PROCESS | 4747 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:22:14 INFO - PROCESS | 4747 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:22:15 INFO - TEST-INFO | 4747: exit 0 20:22:15 INFO - Browser initialized. 20:22:15 INFO - Running cycle 1/1 for kraken test... 20:22:15 INFO - TEST-INFO | started process 4828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_FGUuV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:22:27 INFO - PROCESS | 4828 | RSS: Main: 148840448 20:22:27 INFO - PROCESS | 4828 | 20:22:29 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-beat-detection) 20:22:30 INFO - PROCESS | 4828 | RSS: Main: 188600320 20:22:30 INFO - PROCESS | 4828 | 20:22:33 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-dft) 20:22:33 INFO - PROCESS | 4828 | RSS: Main: 174911488 20:22:33 INFO - PROCESS | 4828 | 20:22:36 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-fft) 20:22:37 INFO - PROCESS | 4828 | RSS: Main: 161955840 20:22:37 INFO - PROCESS | 4828 | 20:22:39 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49470/tests/kraken/driver.html?testName=audio-oscillator) 20:22:39 INFO - PROCESS | 4828 | RSS: Main: 161759232 20:22:39 INFO - PROCESS | 4828 | 20:22:42 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:22:42 INFO - PROCESS | 4828 | RSS: Main: 165294080 20:22:42 INFO - PROCESS | 4828 | 20:22:45 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-darkroom) 20:22:46 INFO - PROCESS | 4828 | RSS: Main: 164179968 20:22:46 INFO - PROCESS | 4828 | 20:22:49 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49470/tests/kraken/driver.html?testName=imaging-desaturate) 20:22:50 INFO - PROCESS | 4828 | RSS: Main: 166182912 20:22:50 INFO - PROCESS | 4828 | 20:22:53 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49470/tests/kraken/driver.html?testName=json-parse-financial) 20:22:53 INFO - PROCESS | 4828 | RSS: Main: 166252544 20:22:53 INFO - PROCESS | 4828 | 20:22:55 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:22:56 INFO - PROCESS | 4828 | RSS: Main: 176857088 20:22:56 INFO - PROCESS | 4828 | 20:22:58 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:22:58 INFO - PROCESS | 4828 | RSS: Main: 174702592 20:22:58 INFO - PROCESS | 4828 | 20:23:00 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:01 INFO - PROCESS | 4828 | RSS: Main: 189853696 20:23:01 INFO - PROCESS | 4828 | 20:23:03 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:04 INFO - PROCESS | 4828 | RSS: Main: 192909312 20:23:04 INFO - PROCESS | 4828 | 20:23:07 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:07 INFO - PROCESS | 4828 | RSS: Main: 192393216 20:23:07 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | Cycle 1(1): loaded http://localhost:49470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49470/tests/kraken/driver.html?testName=ai-astar) 20:23:09 INFO - PROCESS | 4828 | RSS: Main: 251699200 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | __start_tp_report 20:23:09 INFO - PROCESS | 4828 | _x_x_mozilla_page_load 20:23:09 INFO - PROCESS | 4828 | _x_x_mozilla_page_load_details 20:23:09 INFO - PROCESS | 4828 | |i|pagename|runs| 20:23:09 INFO - PROCESS | 4828 | |0;ai-astar;112;113;108;113;112;112;101;121;117;117 20:23:09 INFO - PROCESS | 4828 | |1;audio-beat-detection;155;129;153;167;136;162;151;133;175;129 20:23:09 INFO - PROCESS | 4828 | |2;audio-dft;160;161;162;160;160;159;160;162;162;161 20:23:09 INFO - PROCESS | 4828 | |3;audio-fft;74;74;87;91;72;72;72;112;91;72 20:23:09 INFO - PROCESS | 4828 | |4;audio-oscillator;97;96;132;95;96;96;142;97;97;148 20:23:09 INFO - PROCESS | 4828 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;110;109 20:23:09 INFO - PROCESS | 4828 | |6;imaging-darkroom;146;147;146;148;148;146;147;146;146;146 20:23:09 INFO - PROCESS | 4828 | |7;imaging-desaturate;96;95;98;95;96;96;95;95;96;95 20:23:09 INFO - PROCESS | 4828 | |8;json-parse-financial;70;70;69;70;70;70;68;80;67;69 20:23:09 INFO - PROCESS | 4828 | |9;json-stringify-tinderbox;68;69;68;68;67;68;69;68;70;68 20:23:09 INFO - PROCESS | 4828 | |10;stanford-crypto-aes;84;82;83;83;97;85;91;83;91;83 20:23:09 INFO - PROCESS | 4828 | |11;stanford-crypto-ccm;126;119;129;122;122;127;130;123;129;120 20:23:09 INFO - PROCESS | 4828 | |12;stanford-crypto-pbkdf2;137;150;150;149;161;140;150;165;149;139 20:23:09 INFO - PROCESS | 4828 | |13;stanford-crypto-sha256-iterative;70;72;71;70;71;69;70;70;72;71 20:23:09 INFO - PROCESS | 4828 | __end_tp_report 20:23:09 INFO - PROCESS | 4828 | __start_cc_report 20:23:09 INFO - PROCESS | 4828 | _x_x_mozilla_cycle_collect,1008 20:23:09 INFO - PROCESS | 4828 | __end_cc_report 20:23:09 INFO - PROCESS | 4828 | __startTimestamp1452486189729__endTimestamp 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | ------- Summary: start ------- 20:23:09 INFO - PROCESS | 4828 | Number of tests: 14 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:5.44 (4.8%) stddev-sans-first:5.77 20:23:09 INFO - PROCESS | 4828 | Values: 112.0 113.0 108.0 113.0 112.0 112.0 101.0 121.0 117.0 117.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:16.50 (10.7%) stddev-sans-first:17.36 20:23:09 INFO - PROCESS | 4828 | Values: 155.0 129.0 153.0 167.0 136.0 162.0 151.0 133.0 175.0 129.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 20:23:09 INFO - PROCESS | 4828 | Values: 160.0 161.0 162.0 160.0 160.0 159.0 160.0 162.0 162.0 161.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.00 stddev:13.39 (18.1%) stddev-sans-first:13.91 20:23:09 INFO - PROCESS | 4828 | Values: 74.0 74.0 87.0 91.0 72.0 72.0 72.0 112.0 91.0 72.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.78 (22.7%) stddev-sans-first:22.62 20:23:09 INFO - PROCESS | 4828 | Values: 97.0 96.0 132.0 95.0 96.0 96.0 142.0 97.0 97.0 148.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:23:09 INFO - PROCESS | 4828 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 20:23:09 INFO - PROCESS | 4828 | Values: 146.0 147.0 146.0 148.0 148.0 146.0 147.0 146.0 146.0 146.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 20:23:09 INFO - PROCESS | 4828 | Values: 96.0 95.0 98.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.00 stddev:3.56 (5.1%) stddev-sans-first:3.77 20:23:09 INFO - PROCESS | 4828 | Values: 70.0 70.0 69.0 70.0 70.0 70.0 68.0 80.0 67.0 69.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:23:09 INFO - PROCESS | 4828 | Values: 68.0 69.0 68.0 68.0 67.0 68.0 69.0 68.0 70.0 68.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:84.50 stddev:5.03 (6.0%) stddev-sans-first:5.27 20:23:09 INFO - PROCESS | 4828 | Values: 84.0 82.0 83.0 83.0 97.0 85.0 91.0 83.0 91.0 83.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.50 stddev:4.00 (3.2%) stddev-sans-first:4.22 20:23:09 INFO - PROCESS | 4828 | Values: 126.0 119.0 129.0 122.0 122.0 127.0 130.0 123.0 129.0 120.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:150.00 stddev:8.99 (6.0%) stddev-sans-first:8.43 20:23:09 INFO - PROCESS | 4828 | Values: 137.0 150.0 150.0 149.0 161.0 140.0 150.0 165.0 149.0 139.0 20:23:09 INFO - PROCESS | 4828 | 20:23:09 INFO - PROCESS | 4828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 20:23:09 INFO - PROCESS | 4828 | Values: 70.0 72.0 71.0 70.0 71.0 69.0 70.0 70.0 72.0 71.0 20:23:09 INFO - PROCESS | 4828 | -------- Summary: end -------- 20:23:09 INFO - PROCESS | 4828 | 20:23:10 INFO - TEST-INFO | 4828: exit 0 20:23:10 INFO - TEST-OK | kraken | took 60884ms 20:23:10 INFO - TEST-START | v8_7 20:23:10 INFO - operating with platform_type : linux_ 20:23:10 INFO - Initialising browser for v8_7 test... 20:23:10 INFO - TEST-INFO | started process 5074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOxZYl/profile http://localhost:49470/getInfo.html) 20:23:14 INFO - PROCESS | 5074 | __metrics Screen width/height:1600/1200 20:23:14 INFO - PROCESS | 5074 | colorDepth:24 20:23:14 INFO - PROCESS | 5074 | Browser inner width/height: 1024/697 20:23:14 INFO - PROCESS | 5074 | __metrics 20:23:15 INFO - PROCESS | 5074 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:23:15 INFO - PROCESS | 5074 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:16 INFO - TEST-INFO | 5074: exit 0 20:23:16 INFO - Browser initialized. 20:23:16 INFO - Running cycle 1/1 for v8_7 test... 20:23:16 INFO - TEST-INFO | started process 5155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOxZYl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:28 INFO - PROCESS | 5155 | RSS: Main: 149078016 20:23:28 INFO - PROCESS | 5155 | 20:23:50 INFO - PROCESS | 5155 | Cycle 1(1): loaded http://localhost:49470/tests/v8_7/run.html (next: http://localhost:49470/tests/v8_7/run.html) 20:23:51 INFO - PROCESS | 5155 | RSS: Main: 443052032 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | __start_tp_report 20:23:51 INFO - PROCESS | 5155 | _x_x_mozilla_page_load 20:23:51 INFO - PROCESS | 5155 | _x_x_mozilla_page_load_details 20:23:51 INFO - PROCESS | 5155 | |i|pagename|runs| 20:23:51 INFO - PROCESS | 5155 | |0;Richards;167.8697330871244 20:23:51 INFO - PROCESS | 5155 | |1;DeltaBlue;189.3939393939394 20:23:51 INFO - PROCESS | 5155 | |2;Encrypt;278.55153203342616 20:23:51 INFO - PROCESS | 5155 | |3;Decrypt;5159.79381443299 20:23:51 INFO - PROCESS | 5155 | |4;RayTrace;2070.3933747412007 20:23:51 INFO - PROCESS | 5155 | |5;Earley;807.909604519774 20:23:51 INFO - PROCESS | 5155 | |6;Boyer;12444.444444444445 20:23:51 INFO - PROCESS | 5155 | |7;RegExp;44695.65217391304 20:23:51 INFO - PROCESS | 5155 | |8;Splay;595.9475566150179 20:23:51 INFO - PROCESS | 5155 | |9;NavierStokes;4826.923076923077 20:23:51 INFO - PROCESS | 5155 | __end_tp_report 20:23:51 INFO - PROCESS | 5155 | __startTimestamp1452486231016__endTimestamp 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | ------- Summary: start ------- 20:23:51 INFO - PROCESS | 5155 | Number of tests: 10 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 167.9 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 189.4 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 278.6 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 5159.8 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#4] RayTrace Cycles:1 Average:2070.39 Median:2070.39 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 2070.4 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#5] Earley Cycles:1 Average:807.91 Median:807.91 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 807.9 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 12444.4 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#7] RegExp Cycles:1 Average:44695.65 Median:44695.65 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 44695.7 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#8] Splay Cycles:1 Average:595.95 Median:595.95 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 595.9 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - PROCESS | 5155 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:23:51 INFO - PROCESS | 5155 | Values: 4826.9 20:23:51 INFO - PROCESS | 5155 | -------- Summary: end -------- 20:23:51 INFO - PROCESS | 5155 | 20:23:51 INFO - TEST-INFO | 5155: exit 0 20:23:51 INFO - TEST-OK | v8_7 | took 41265ms 20:23:51 INFO - SUITE-END | took 1219s 20:23:52 INFO - Completed test suite (00:20:19) 20:23:52 INFO - Working with test: dromaeo_css 20:23:52 INFO - Generating results file: dromaeo_css 20:23:52 INFO - Working with test: kraken 20:23:52 INFO - Generating results file: kraken 20:23:52 INFO - javascript benchmark 20:23:52 INFO - Working with test: v8_7 20:23:52 INFO - Generating results file: v8_7 20:23:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 20:23:52 INFO - process_Request line: dromaeo_css 6083.46 graph.html#tests=[[72,203,35]] 20:23:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:52 INFO - process_Request line: kraken 1534.20 graph.html#tests=[[232,203,35]] 20:23:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:23:52 INFO - process_Request line: v8_7 18680.79 graph.html#tests=[[230,203,35]] 20:23:52 INFO - RETURN: dromaeo_css: 6083.46 20:23:52 INFO - RETURN: kraken: 1534.20 20:23:52 INFO - RETURN: v8_7: 18680.79 20:23:52 INFO - javascript benchmark 20:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2561.6669832921725, 2642.392249782551, 2645.9603105953415, 2660.9866950665246, 2671.105179764779, 4337.414449049377, 4471.5081341052455, 4491.3263010548435, 4494.325851122333, 4500.279955207164, 4473.575010374017, 4487.596116349528, 4530.524294949032, 4553.726776393419, 4600.447946246447, 4086.509618845728, 4130.070734084829, 4168.270552653274, 4242.448481697391, 4250.511191213003, 3989.5412027616903, 4191.937120943188, 4225.68307376948, 4255.553166917475, 4275.230458517465, 4113.382992551096, 4117.876463706094, 4136.090060186754, 4226.640735537483, 4243.257429949777, 4201.033762234703, 4222.767747773872, 4223.809928553223, 4225.345071513921, 4259.8083086261195, 4192.874213773592, 4208.473940757405, 4216.451861258048, 4236.745795252264, 4245.532991370947, 4283.593058659453, 4336.457942757155, 4383.736975781431, 4412.24991751403, 4432.468103827561, 4796.832110876103, 4798.232282834764, 4802.447718512381, 4815.0, 4839.7096174229655, 4812.614990800727, 4816.710997340171, 4821.710697358169, 4822.855314340575, 4831.347768051303, 4289.463817022904, 4392.516823149451, 4395.099004704028, 4471.7987690554, 4506.774661266923, 4915.4347250065985, 4922.040202160544, 4933.777979990909, 4933.802647894116, 4960.330355401975, 4736.289556566542, 4745.145873742759, 4748.6438517111355, 4750.809967601326, 4793.880152996203, 4692.0, 4728.290756386569, 4801.375821143229, 4801.903961920742, 4820.469748327681, 4779.713217206979, 4802.711837289774, 4808.3027960945465, 4809.422869255712, 4821.373221481185, 4784.880377990578, 4791.784369703371, 4798.1123492153365, 4800.3279540864305, 4802.639802014863, 3983.3029219886403, 4085.836566537365, 4133.627973482341, 4133.937990930139, 4137.689673274516, 3565.1800085979853, 3597.2086141048926, 3606.1886075633297, 3621.4386770050683, 3658.70730341572, 4192.790360481964, 4198.475190601175, 4200.474940632421, 4216.494020717533, 4239.576042395797, 4657.510961349078, 4834.20235661112, 4865.367502224759, 4876.390451193601, 4927.9507204927495, 4036.858709945138, 4045.959540404617, 4047.9392809107885, 4109.835606575763, 4194.3708443733685, 4311.611954924072, 4326.978365108154, 4337.869863904025, 4342.913141737147, 4379.211741886491, 4610.930836037395, 4615.446146462446, 4622.14490319292, 4624.78966914572, 4634.096351211549, 4584.908301834012, 4701.435827700698, 4703.74129422885, 4768.976155119202, 4866.416030076413, 4639.373684552677, 4652.790624421977, 4653.1391692535635, 4684.0, 4695.694779839299, 4795.760211989456, 4807.062622788522, 4816.133096042606, 4817.8313759018265, 4851.393575803025, 4638.605718513964, 4771.5467030632035, 4773.164696178224, 4775.403074615673, 4849.757512124309, 4616.422947131608, 4618.284165954283, 4649.790759415767, 4664.253719404879, 4666.393368862026, 4630.398048253705, 4659.813607455664, 4771.64212684057, 4773.284007398918, 4781.7609119543185, 4561.2473941799235, 4569.063342014945, 4583.977080114578, 4585.403897493305, 4596.3565100885235, 4668.5564871337165, 4669.066186762729, 4674.158651442773, 4681.297805329228, 4717.2216584263215, 4367.45406824147, 4477.238869392277, 4479.641628669764, 4575.450945886515, 4691.483936766885], "unit": "score", "name": "dojo.html", "value": 4427.884420935051}, {"lowerIsBetter": false, "replicates": [490.65899200055964, 493.1517789402227, 495.7124867576806, 496.4836569967234, 530.6418167736776, 24990.37524061897, 32682.0, 33180.5022924656, 33318.33363332732, 33335.16662083449, 36085.278294434094, 36534.45198322027, 36564.0, 36606.0, 36607.816960915225, 6773.153355830521, 6899.0, 7522.285382888617, 7711.652975616083, 7716.922830771705, 9460.479673617949, 9681.177099946513, 9695.418274903494, 9704.854427183598, 9705.757356066084, 9669.758256043584, 9775.462349570771, 9778.462184579845, 9781.657641982532, 9784.217262618973, 9512.286578506604, 9651.372660777097, 9673.467959262238, 9677.274204434696, 9680.515974201333, 9519.333646644738, 9672.75818104546, 9680.56437460309, 9919.206463482904, 10008.149307308888, 37211.81394093012, 37583.81208093942, 37610.43584346237, 37665.3501974706, 37674.43488347677, 2894.82631042136, 2954.3500429905384, 2959.3489432324855, 3377.1800546543664, 3571.8727458149992, 28878.71121288781, 28894.566581501294, 28953.0, 28987.56518652222, 29188.854055729586, 3373.1567108222944, 3384.881529146468, 3393.2704468539137, 3442.1050526862946, 3486.459598762196, 213303.0, 215293.92353038292, 215394.0, 215840.0, 216492.0, 44856.0, 45828.0, 54021.72989135029, 54597.0, 55162.448375516535, 45881.311780323325, 46113.53886461093, 46249.0, 46486.0, 46631.766841165576, 13613.11514751538, 13825.930870345584, 13832.654183645289, 13841.169529828243, 13845.584632460841, 9672.274579406572, 9684.95157524208, 9685.854712179324, 9695.951520242495, 9789.118979291898, 18128.365507207185, 18497.260109595736, 18500.629987400447, 18516.259349626132, 18574.81425185758, 6924.0, 7163.42692584592, 7242.855142897218, 7247.275272472816, 7351.852962940711, 860.8665656823202, 877.2455688108222, 901.7970956534728, 1004.5680357446222, 1049.6693541534391, 25608.743912560636, 25712.12000319159, 25730.0, 25910.611340829902, 26209.0, 932.5337331334333, 959.3332633819429, 971.7910649210312, 1007.4005966449951, 1035.1822060572063, 12134.635960921187, 12201.633950981484, 12225.44985475638, 12263.693407664701, 12283.0, 257756.0, 260262.0, 260515.0, 260686.0, 262108.0, 43921.34117988233, 44118.558814411444, 44158.55841441544, 44172.55827441749, 44177.0, 1210.5278941212935, 1233.734747029375, 1241.5344245907784, 1249.09440655524, 1255.918365306252, 20680.0, 25817.354566135997, 25944.06572976452, 26313.73686263113, 26593.202203933914, 39251.0, 39642.0, 39643.0, 39693.60306397015, 39706.40440393339, 164265.17867411065, 164712.0, 164837.0, 165330.0, 165563.0, 23842.523149536566, 24313.270601881974, 27230.0, 27597.31006724848, 28137.0, 32150.83924580362, 32442.675573243967, 32648.51027234546, 32899.50650740193, 33342.83328583342, 28160.85919570389, 28414.57378139371, 28554.571681425212, 28675.713242867303, 29278.7072129276, 24311.63532546978, 27961.580576291777, 28490.287742805765, 31266.11520977664, 32213.677863221066, 29820.701792981792, 30591.847040764653, 30898.382032359677, 30937.215650590653, 30970.070897873098, 25661.0, 29305.706942930297, 30111.548326775555, 30224.5466318001, 30366.240843979078, 21187.152513899273, 22239.66640500426, 22303.0, 22468.0, 22510.774892251524], "unit": "score", "name": "ext.html", "value": 16232.355424904685}, {"lowerIsBetter": false, "replicates": [323.5648053368219, 330.39042965728237, 330.94208513510137, 335.50177985691244, 339.4162041288985, 12000.219985700945, 12464.81302780459, 14607.342669579868, 14736.336864841094, 14996.625084372883, 12761.61715148547, 13654.0, 15431.228438578082, 15641.0, 15661.686766264667, 4774.928376074353, 5060.4686507916695, 5066.341375621164, 5067.822626208065, 5069.44236134025, 3716.3310604091253, 3840.9807950960208, 4882.9511704883025, 4961.603071754251, 4965.255211718235, 5673.404292549285, 5895.056790913454, 5911.556633252501, 5924.170616113726, 5937.4656280934705, 5650.943490565083, 5715.199872017921, 5719.48524632785, 5727.055035919089, 5740.684262365568, 4788.856334309976, 4948.208286674151, 4971.4282857471135, 5034.144195486776, 5050.595952323805, 18037.819621803745, 18144.637107257782, 18392.356267530573, 18399.448016559523, 18615.162317695736, 578.8871170121828, 580.886727088218, 581.8516278349036, 1906.8474522038205, 1956.833669138125, 11786.292822430596, 11885.22746021506, 11968.940155299255, 12205.633830985085, 12497.93751031248, 1770.5750619851271, 1779.8665100117414, 1782.857371410284, 1824.6350729854082, 1853.7775466943917, 44088.11823763507, 47364.52635473636, 47746.0, 47928.76035619834, 48564.75717621425, 8809.33929955256, 8999.235065019546, 9101.317401194938, 9101.453912765255, 9112.225460835904, 11647.41762911868, 11656.941715291368, 11672.766544669059, 11680.123990700562, 11691.298522088531, 6106.832074613537, 6464.0, 6599.637019963948, 6651.567648102858, 6750.0, 6400.935990640127, 6503.382178693017, 6558.8360290993105, 6605.1083103780375, 6619.3380661933425, 3983.063979964706, 4068.044009657728, 4070.1452694933805, 4100.1184745279315, 4119.7940102994735, 1604.8555629993357, 1645.12808211648, 1645.5886028492878, 1648.4395305596154, 1696.711559034967, 382.95213098362706, 800.3757069485811, 812.7155495576501, 922.8846394200725, 928.3872644054892, 9252.7686807829, 9444.95277523608, 9606.903930960601, 9712.02879712023, 9785.0, 394.2627286973378, 402.8831638824708, 403.1655965357611, 405.9431679564863, 417.98328066877593, 5123.0522353364, 5157.819476318386, 5295.761690723926, 5399.460053994648, 5463.153211252262, 402893.7829662787, 403270.0, 426168.0, 429049.0, 431120.0, 64319.71360572762, 65099.349006510274, 65596.0, 65873.67063164653, 66613.66693166504, 982.9017098290113, 1024.8923862994427, 1029.2023681646783, 1031.2471895516314, 1049.9580016799243, 13718.93140534291, 14008.649783755487, 14225.857741422868, 14298.499552515612, 14449.277536123362, 19497.02514874279, 19958.0, 28331.291717707223, 29670.961516346822, 31464.842675786476, 39590.802045989585, 40347.0, 40468.595314046484, 40575.59424405836, 40630.1873962525, 6364.0, 6582.432851187945, 6599.472042236705, 6890.276520965226, 6914.0320355149315, 9089.727308180765, 9852.113309802153, 9867.161291290033, 9900.801983960137, 9983.201343892326, 7753.651085701044, 8047.356211502949, 8181.0, 8323.500589964622, 8402.41183117176, 8366.163383661586, 8439.156084391512, 8755.299576033774, 9176.495292758962, 9555.569999350186, 8414.915850841413, 8503.914960850312, 8589.82820343577, 8598.269147122564, 8976.102389761232, 5116.181410974226, 6279.340669229665, 6799.490038247052, 6810.31896810315, 7003.509754317352, 6903.689333980084, 8389.454685445426, 8556.401051926305, 8579.699710510102, 8681.8697719533], "unit": "score", "name": "jquery.html", "value": 6963.0874705584365}, {"lowerIsBetter": false, "replicates": [1423.9288035598217, 1442.747519184143, 1586.5002524204874, 1750.9912450437746, 1780.187304059586, 6461.70922308496, 6640.933590664092, 7113.075300210971, 7269.382102521286, 7270.454715896309, 6907.792766217009, 7025.227225005258, 7082.397996170319, 7084.043654106694, 7088.432925365972, 2070.8446866484996, 2097.947551311222, 2098.1607357057146, 2102.3692892132376, 2102.4008157675066, 1793.2468363287385, 1835.5869929265941, 2065.5559054803216, 2118.8093071623553, 2130.1798807459086, 2103.9894800525976, 2118.163325486432, 2127.7446706395253, 2131.211451762842, 2131.3073251193346, 2090.341542414142, 2114.7356580427445, 2118.9788102118937, 2119.4171602809197, 2122.7877212278804, 2089.529855782452, 2104.1057550541113, 2122.7877212278804, 2137.6045431595203, 2140.4541841830387, 7666.846663066707, 7683.57740324282, 7742.303192712627, 7742.341900938427, 7748.147703752583, 4317.805698743564, 4433.002574420761, 4448.33275008748, 4465.508794032654, 4466.731996080213, 2820.6333176687103, 2849.2734352740126, 2854.6717127530183, 2883.9134825955043, 2910.432465669195, 941.9811603767886, 947.5925352098595, 966.7728083900278, 976.6776963601994, 1018.9388636681749, 10759.139268858473, 10789.136869050535, 10792.028717415391, 10798.136149108053, 10804.297720648132, 3913.92172156561, 4028.1742242840146, 4032.919341613151, 4050.858219962287, 4108.650764684976, 9192.17270445663, 9192.908070919339, 9203.815923681488, 9207.355485115977, 9213.63145474187, 4404.889877753082, 4412.139632771578, 4420.071784925138, 4447.132809102259, 4454.888627784267, 3966.4729079304675, 3998.1803730235233, 4000.7999600019884, 4001.9399709004388, 4005.1989602079702, 3420.9828950855585, 3540.345036168317, 3551.5738111426795, 3556.3065202285306, 3560.3235385276716, 946.4652471353663, 1000.309786247487, 1086.2342048855537, 1103.1230172013268, 1109.9278546894589, 1163.1044096046166, 1169.7601991591703, 1184.1592469346688, 1185.7315646501258, 1204.6867814368152, 7178.2103968563415, 7268.0, 7315.085614298213, 7345.118585769742, 7372.078490188726, 1052.1372474570778, 1064.7763969566322, 1072.1637123044038, 1080.2384319055047, 1080.6163811846839, 5506.063969125258, 5619.80330688424, 5631.2397826293745, 5633.549316054706, 5635.098384258499, 9041.141091596288, 9327.720168394959, 9353.625854965725, 9501.382410143457, 9601.183899368632, 9311.627534898527, 9383.859242111374, 9461.621535138518, 9463.337566370288, 9513.904860951441, 7026.789196324118, 7149.678264478111, 7316.670749816271, 7319.926800732031, 7336.926630733731, 6920.550164239308, 6977.965110174417, 6982.79051628452, 6994.61529615876, 7015.824604384727, 8092.312153466786, 8293.087760346478, 8301.211384918422, 8521.616527256412, 8529.786755331166, 8452.239298463168, 8640.870386944327, 8706.216440520384, 8734.82530349402, 8771.692990745549, 6708.228553716385, 6710.530262881747, 6746.291639377795, 6778.220504641832, 6797.150356205474, 6000.849978750566, 7321.304476074764, 7369.557826530426, 7372.778816635509, 7405.0, 5634.526544628208, 6085.6348619083, 6175.814725558061, 6707.4969377297875, 6798.048273241849, 6419.197600299963, 6468.450181734605, 6517.283098859217, 6540.705668244846, 6616.2722100567935, 6713.966430167818, 6795.048693182859, 6795.082663840319, 6796.116504854337, 6814.318568143146, 5899.557533184942, 6100.6949652516305, 6102.786402475892, 6119.632822030692, 6137.079438084323, 6330.715117819617, 6371.076193951943, 6375.107484952017, 6388.840278993062, 6394.0408938659575], "unit": "score", "name": "mootools.html", "value": 4303.774525621763}, {"lowerIsBetter": false, "replicates": [314.50151509856875, 318.087090051552, 320.6104582931736, 322.3247296912968, 324.8164786895404, 5169.483051694829, 5284.947150528494, 5325.414204437514, 5351.357837059559, 5358.2766326546, 5234.476552344764, 5238.8690282742855, 5239.79040838366, 5247.055530004607, 5248.47515248475, 3919.314120028998, 3958.168784555247, 4000.0599859033105, 4108.4248205251215, 4111.1366613011305, 4059.654929330996, 4069.7965101744944, 4075.8369665213504, 4075.9388609170887, 4086.795660216992, 4027.3556231003045, 4034.778087205217, 4050.7772072536, 4058.9188216235657, 4060.654844338235, 3843.3082045231845, 3932.429797679349, 3954.0, 4033.4353190553347, 4040.8181631826637, 3594.0, 3594.802285874276, 3607.026102952188, 3611.8916432507067, 3612.6387361263664, 5026.145555255579, 5028.522290382444, 5031.0, 5033.219850923113, 5040.319556859814, 4663.207254766698, 4678.087772884289, 4681.648876334289, 4687.062587482517, 4694.859154225379, 5355.571554275688, 5479.123340265578, 5484.91772623411, 5484.91772623411, 5493.478119578634, 3912.68698504119, 3916.314644937153, 3919.510061242345, 3923.941140882889, 3923.98038009811, 5770.307563092456, 5773.711314434304, 5779.306483221998, 5781.71091445426, 5792.710364481759, 4021.698372622065, 4041.878743637637, 4044.8988775280263, 4047.696422768245, 4052.412400202013, 3852.903677408031, 3907.8632247871187, 4106.199291138199, 4108.383742438658, 4108.4453598764385, 4556.225441674923, 4631.976840115778, 4643.466001409881, 4644.419447569054, 4646.581807637262, 5465.207544905967, 5515.227868098469, 5522.199281104217, 5523.061079616475, 5525.723713814293, 1453.7383271011108, 1470.6838029823639, 1471.8748906342867, 1472.1976522795103, 1472.2197235465221, 1014.2899970021015, 1015.9847602285971, 1021.6015753856002, 1030.5465595138114, 1035.2856528994969, 4839.903201935942, 4847.224444088929, 4852.4662287148385, 4853.6602437829015, 4856.562909338177, 5714.114312281603, 5717.485426311652, 5721.599488035798, 5726.4273572642405, 5729.28383952006, 4846.733429661403, 4852.539008794159, 4852.805887764521, 4853.878653033702, 4855.174620314555, 2985.6566494852937, 3051.9237019074258, 3084.8303343315883, 3085.460044492205, 3085.8302793346134, 5466.508014278734, 5475.890482190334, 5487.533559647395, 5492.670439773627, 5498.780048798083, 5929.911051334234, 5935.2877654681715, 5938.554608404387, 5943.673097979567, 5946.10808378738, 5481.232627432242, 5488.725563721798, 5493.505584497414, 5493.725313734298, 5498.5876059295715, 5633.126865335879, 5764.423557644202, 5778.27771528559, 5786.045302525036, 5789.973509271721, 5655.688937108499, 5656.88686226265, 5660.9150862737915, 5660.971695141663, 5664.603477756517, 5487.972560137174, 5497.917531236954, 5522.751476183662, 5553.389127196086, 5555.055640541199, 3959.8218080185884, 4000.9199816004098, 4002.0795217100813, 4043.1711499143194, 4048.473698419187, 5542.808296216333, 5684.232628595087, 5759.596828222152, 5765.308163020297, 5777.62445441045, 5405.189221616789, 5503.587230957774, 5516.117421212587, 5518.2826232589505, 5552.666839989613, 5541.667499950016, 5542.5565954722715, 5544.0, 5546.75039623226, 5549.7780088796, 5327.3074500314715, 5438.700871452108, 5441.102218134122, 5443.537299329601, 5445.83662490126, 5579.079451890392, 5580.135079062752, 5588.944110558842, 5589.524890384363, 5590.9440905592055, 5439.646422982493, 5454.127339625641, 5459.672419654833, 5462.262594549844, 5478.150886612581], "unit": "score", "name": "prototype.html", "value": 4181.414884691906}, {"lowerIsBetter": false, "replicates": [710.8151880511066, 740.4150720930465, 747.558940225267, 761.3642608421967, 781.4178437064388, 10820.78358432832, 10964.780704385908, 10964.835527467094, 10965.725856853584, 10969.670909872697, 11112.555497780078, 11112.722181945455, 11119.221654484189, 11164.330140191594, 11181.83227251592, 600.6126048698587, 607.3380015782795, 754.366332280884, 770.7841804294807, 770.9113451953041, 784.0630446616295, 785.9960700196491, 787.3543694170754, 789.1043665439738, 790.6442101054548, 827.3009307135461, 827.8096037911254, 828.7596596986866, 829.1832544943226, 830.0703212402118, 636.3541005879036, 646.8027251688234, 812.0417906869891, 827.6730691376872, 829.2081062585216, 611.5199568338877, 611.5627326461557, 611.6544152553837, 611.6972098811073, 611.721666641677, 11393.772124557463, 11427.371494567795, 11449.0, 11467.598634047768, 11474.426278686033, 10589.364638121737, 10838.0, 11003.724906877393, 11198.720031999184, 11229.045531129783, 9130.634774609007, 9250.028746981538, 9256.537173141383, 9270.675526356612, 9541.141297283279, 3233.3371658810124, 3248.561444205049, 3293.4236508610898, 3312.2381852174135, 3315.8010519368913, 37293.627063729284, 37294.25411491755, 37318.25363492742, 37401.438978415346, 37442.25115497702, 9477.810443791224, 9591.280653950982, 9622.855657165148, 9683.031696830401, 9742.512874356396, 16766.07786571726, 16767.664646707, 16791.32834686599, 16794.58013549671, 16811.495655130366, 6613.338666133444, 6636.502262330345, 6641.136652235178, 6695.899561506581, 6820.522563420612, 3722.6970560304217, 3763.9623603764157, 3811.5045044144085, 3815.42768584709, 3830.9808450957566, 2503.7871780898827, 2534.9873250633627, 2540.6697129373065, 2543.6438898554215, 2547.50323686883, 451.9344695019204, 453.5509845253176, 462.20039331955235, 469.36635542018684, 469.84729962761554, 495.81040210223756, 501.1280372152501, 540.7269328988835, 589.5195415736247, 649.9025146228104, 6658.300878407795, 6679.833004174934, 6777.695003724844, 7668.693252269847, 7863.37093032556, 497.8474830766763, 505.53490788474693, 539.6600141910571, 607.9148919151322, 651.4267444648679, 3768.4347347898033, 3894.299026175259, 3973.543042550086, 4017.4777278953547, 4045.089854782709, 45010.0, 45927.31109033367, 45991.0, 46029.0, 46178.53821461809, 40687.79656101701, 41128.38307425331, 41202.58797411987, 41406.79296603498, 42077.57922420798, 37103.4434483483, 37142.8142859284, 37741.62258377381, 37814.0, 38863.22273554513, 7802.375809935305, 8061.556614386265, 8254.257116859511, 8287.83424331498, 8582.699605513777, 31049.223769405944, 31357.84321078471, 31940.201494961882, 33141.337173256885, 33898.66101338955, 41042.0, 41122.794386027876, 41429.0, 42468.362974556025, 42533.57466425296, 10225.43760093202, 10256.487175641338, 10529.736756581147, 10608.204384671335, 10717.517711703147, 10835.620753273597, 10976.396298203676, 11061.079199908549, 11130.16523760705, 11497.367644779617, 10435.37387756737, 10483.423411712429, 10723.731906702395, 10736.570537178426, 10931.289466184673, 10564.683059508227, 10569.841452378067, 10604.946975265382, 10639.574417023232, 10805.351678899291, 10096.293259471766, 10147.79704405893, 10162.74593135148, 10225.74435639115, 10426.843597345895, 8480.533570653426, 8930.598123084606, 9017.278617710435, 9169.495677737788, 9393.624255029723, 9032.277417806692, 9288.814223715623, 9331.113544213289, 9408.623655053721, 9455.574499147693], "unit": "score", "name": "yui.html", "value": 5627.432985664936}], "name": "dromaeo_css", "value": 6083.4591586408915}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 112.0, 112.0, 101.0, 121.0, 117.0, 117.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 153.0, 167.0, 136.0, 162.0, 151.0, 133.0, 175.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 160.0, 160.0, 159.0, 160.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 87.0, 91.0, 72.0, 72.0, 72.0, 112.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 132.0, 95.0, 96.0, 96.0, 142.0, 97.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 148.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 98.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 68.0, 80.0, 67.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 83.0, 97.0, 85.0, 91.0, 83.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [126.0, 119.0, 129.0, 122.0, 122.0, 127.0, 130.0, 123.0, 129.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 150.0, 149.0, 161.0, 140.0, 150.0, 165.0, 149.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 71.0, 70.0, 71.0, 69.0, 70.0, 70.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1534.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [2070.3933747412007], "unit": "score", "name": "RayTrace", "value": 357.41468700000013}, {"lowerIsBetter": false, "replicates": [807.909604519774], "unit": "score", "name": "Earley", "value": 824.9227342657342}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [44695.65217391304], "unit": "score", "name": "RegExp", "value": 20.38196011673151}, {"lowerIsBetter": false, "replicates": [595.9475566150179], "unit": "score", "name": "Splay", "value": 136.74189800000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18680.792959572984}]} 20:23:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "18680.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1534.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6083.46"}}} 20:23:52 INFO - Return code: 0 20:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:52 INFO - # TBPL SUCCESS # 20:23:52 INFO - Running post-action listener: _resource_record_post_action 20:23:52 INFO - Running post-run listener: _resource_record_post_run 20:23:53 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 24576; Write bytes: 550465536; Read time: 328; Write time: 372088 20:23:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 231981056; Read time: 80; Write time: 189028 20:23:53 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 20480; Write bytes: 318484480; Read time: 248; Write time: 183060 20:23:53 INFO - Running post-run listener: _upload_blobber_files 20:23:53 INFO - Blob upload gear active. 20:23:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:23:54 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:55 INFO - (blobuploader) - INFO - Done attempting. 20:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:55 INFO - (blobuploader) - INFO - Done attempting. 20:23:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:23:55 INFO - Return code: 0 20:23:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:23:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:23:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/fe9ba8653b17afea54668272e58220b6055e44c0a90b1d14602d192ddfe05a057b533e8d74c5e13c8868a410b428da96cfab7a348af2ef38c40121226b8fa632", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0a9856e416147c419e282bc4f904ae28957d0e40085a8569670136881026ce5494fa4ebe9e51ead4e4b2893082d8ee1a53c138685eff72e1d1f70de3d32360a7"} 20:23:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:23:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:23:55 INFO - Contents: 20:23:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/fe9ba8653b17afea54668272e58220b6055e44c0a90b1d14602d192ddfe05a057b533e8d74c5e13c8868a410b428da96cfab7a348af2ef38c40121226b8fa632", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0a9856e416147c419e282bc4f904ae28957d0e40085a8569670136881026ce5494fa4ebe9e51ead4e4b2893082d8ee1a53c138685eff72e1d1f70de3d32360a7"} 20:23:55 INFO - Copying logs to upload dir... 20:23:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.186264 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-10 20:23:55.517632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:23:55.520965) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/fe9ba8653b17afea54668272e58220b6055e44c0a90b1d14602d192ddfe05a057b533e8d74c5e13c8868a410b428da96cfab7a348af2ef38c40121226b8fa632", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0a9856e416147c419e282bc4f904ae28957d0e40085a8569670136881026ce5494fa4ebe9e51ead4e4b2893082d8ee1a53c138685eff72e1d1f70de3d32360a7"} build_url:https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011398 build_url: 'https://queue.taskcluster.net/v1/task/YGHy8BWHR0qL1Cp78Kbf-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/fe9ba8653b17afea54668272e58220b6055e44c0a90b1d14602d192ddfe05a057b533e8d74c5e13c8868a410b428da96cfab7a348af2ef38c40121226b8fa632", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/0a9856e416147c419e282bc4f904ae28957d0e40085a8569670136881026ce5494fa4ebe9e51ead4e4b2893082d8ee1a53c138685eff72e1d1f70de3d32360a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 20:23:55.546108) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:23:55.546491) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1452482472.625290-2090442587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 20:23:55.631839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:23:55.632621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 20:23:55.633276) ========= ========= Total master_lag: 0.27 =========