builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1467045183.63 results: success (0) buildid: 20160627064925 builduid: 96e5c251132847da8a26a4cfa95a6d96 revision: 34281fb8a330ef0731305992a25bd88c66a8cfe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.633175) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.633686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.633969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.649198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.649498) ========= 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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 09:33:03-- 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% 87.0M=0s 2016-06-27 09:33:03 (87.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078042 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.741075) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.741368) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019945 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.827519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:03.827856) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 34281fb8a330ef0731305992a25bd88c66a8cfe8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 34281fb8a330ef0731305992a25bd88c66a8cfe8 --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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 09:33:03,972 truncating revision to first 12 chars 2016-06-27 09:33:03,973 Setting DEBUG logging. 2016-06-27 09:33:03,973 attempt 1/10 2016-06-27 09:33:03,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/34281fb8a330?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 09:33:04,295 unpacking tar archive at: mozilla-beta-34281fb8a330/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:04.477029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:04.477347) ========= script_repo_revision: 34281fb8a330ef0731305992a25bd88c66a8cfe8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:04.477765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:04.478029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 09:33:04.488637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-27 09:33:04.489026) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:33:04 INFO - MultiFileLogger online at 20160627 09:33:04 in /builds/slave/test 09:33:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:33:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:04 INFO - {'append_to_log': False, 09:33:04 INFO - 'base_work_dir': '/builds/slave/test', 09:33:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:33:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:04 INFO - 'branch': 'Mozilla-Beta', 09:33:04 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:04 INFO - 'config_files': ('talos/linux_config.py',), 09:33:04 INFO - 'default_actions': ('clobber', 09:33:04 INFO - 'read-buildbot-config', 09:33:04 INFO - 'download-and-extract', 09:33:04 INFO - 'populate-webroot', 09:33:04 INFO - 'create-virtualenv', 09:33:04 INFO - 'install', 09:33:04 INFO - 'run-tests'), 09:33:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:04 INFO - 'download_minidump_stackwalk': True, 09:33:04 INFO - 'download_symbols': 'ondemand', 09:33:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:04 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:04 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:04 INFO - 'installer_path': 'installer.exe', 09:33:04 INFO - 'log_level': 'info', 09:33:04 INFO - 'log_name': 'talos', 09:33:04 INFO - 'log_to_console': True, 09:33:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:33:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:33:04 INFO - 'opt_config_files': (), 09:33:04 INFO - 'pip_index': False, 09:33:04 INFO - 'sps_profile': False, 09:33:04 INFO - 'sps_profile_interval': 0, 09:33:04 INFO - 'suite': 'dromaeojs-e10s', 09:33:04 INFO - 'system_bits': '32', 09:33:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:04 INFO - 'title': 'talos-linux64-ix-038', 09:33:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:04 INFO - 'use_talos_json': True, 09:33:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:04 INFO - 'work_dir': 'build'} 09:33:04 INFO - ##### 09:33:04 INFO - ##### Running clobber step. 09:33:04 INFO - ##### 09:33:04 INFO - Running pre-action listener: _resource_record_pre_action 09:33:04 INFO - Running main action method: clobber 09:33:04 INFO - rmtree: /builds/slave/test/build 09:33:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:05 INFO - Running post-action listener: _resource_record_post_action 09:33:05 INFO - ##### 09:33:05 INFO - ##### Running read-buildbot-config step. 09:33:05 INFO - ##### 09:33:05 INFO - Running pre-action listener: _resource_record_pre_action 09:33:05 INFO - Running main action method: read_buildbot_config 09:33:05 INFO - Using buildbot properties: 09:33:05 INFO - { 09:33:05 INFO - "project": "", 09:33:05 INFO - "product": "firefox", 09:33:05 INFO - "script_repo_revision": "production", 09:33:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:33:05 INFO - "repository": "", 09:33:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:33:05 INFO - "buildid": "20160627064925", 09:33:05 INFO - "pgo_build": "True", 09:33:05 INFO - "basedir": "/builds/slave/test", 09:33:05 INFO - "buildnumber": 18, 09:33:05 INFO - "slavename": "talos-linux64-ix-038", 09:33:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:05 INFO - "platform": "ubuntu64_hw", 09:33:05 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:33:05 INFO - "branch": "mozilla-beta", 09:33:05 INFO - "repo_path": "releases/mozilla-beta", 09:33:05 INFO - "revision": "34281fb8a330ef0731305992a25bd88c66a8cfe8", 09:33:05 INFO - "stage_platform": "linux64-pgo", 09:33:05 INFO - "builduid": "96e5c251132847da8a26a4cfa95a6d96", 09:33:05 INFO - "slavebuilddir": "test" 09:33:05 INFO - } 09:33:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:33:05 INFO - Running post-action listener: _resource_record_post_action 09:33:05 INFO - ##### 09:33:05 INFO - ##### Running download-and-extract step. 09:33:05 INFO - ##### 09:33:05 INFO - Running pre-action listener: _resource_record_pre_action 09:33:05 INFO - Running main action method: download_and_extract 09:33:05 INFO - mkdir: /builds/slave/test/build/tests 09:33:05 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')]} 09:33:05 INFO - https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:33:05 INFO - Downloaded 1327 bytes. 09:33:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:33:05 INFO - Using the following test package requirements: 09:33:05 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:33:05 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:33:05 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:33:05 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'jsshell-linux-x86_64.zip'], 09:33:05 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:33:05 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:33:05 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:33:05 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:33:05 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:33:05 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:33:05 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:33:05 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:33:05 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')]} 09:33:05 INFO - https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:07 INFO - Downloaded 24234670 bytes. 09:33:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:08 INFO - Return code: 0 09:33:08 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:33:08 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')]} 09:33:08 INFO - https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:33:09 INFO - Downloaded 24234670 bytes. 09:33:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:33:10 INFO - Return code: 0 09:33:10 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')]} 09:33:10 INFO - https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:33:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:33:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:33:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:12 INFO - Downloaded 10840145 bytes. 09:33:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:33:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:33:12 INFO - Return code: 0 09:33: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')]} 09:33:12 INFO - https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:33:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:33:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:33:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:33:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:33:16 INFO - Downloaded 56005147 bytes. 09:33:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:33:16 INFO - mkdir: /builds/slave/test/properties 09:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:16 INFO - Contents: 09:33:16 INFO - build_url:https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:33:17 INFO - Running post-action listener: _resource_record_post_action 09:33:17 INFO - Running post-action listener: set_extra_try_arguments 09:33:17 INFO - ##### 09:33:17 INFO - ##### Running populate-webroot step. 09:33:17 INFO - ##### 09:33:17 INFO - Running pre-action listener: _resource_record_pre_action 09:33:17 INFO - Running main action method: populate_webroot 09:33:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:17 INFO - '--tppagecycles', 09:33:17 INFO - '7'], 09:33:17 INFO - 'tests': ['tsvgm']}}, 09:33:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['damp', 'tps']}, 09:33:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['damp', 'tps']}, 09:33:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['dromaeo_dom']}, 09:33:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['a11yr', 09:33:17 INFO - 'ts_paint', 09:33:17 INFO - 'tpaint', 09:33:17 INFO - 'sessionrestore', 09:33:17 INFO - 'sessionrestore_no_auto_restore', 09:33:17 INFO - 'tabpaint']}, 09:33:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['tsvgx', 09:33:17 INFO - 'tsvgr_opacity', 09:33:17 INFO - 'tart', 09:33:17 INFO - 'tscrollx', 09:33:17 INFO - 'cart']}, 09:33:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:17 INFO - 'tsvgr_opacity', 09:33:17 INFO - 'tart', 09:33:17 INFO - 'tscrollx', 09:33:17 INFO - 'cart']}, 09:33:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--disable-e10s'], 09:33:17 INFO - 'tests': ['tp5o']}, 09:33:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'tests': ['tp5o']}, 09:33:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--disable-e10s', 09:33:17 INFO - '--xperf_path', 09:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:17 INFO - 'tests': ['tp5n']}, 09:33:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:17 INFO - 'talos_options': ['--xperf_path', 09:33:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:17 INFO - 'tests': ['tp5n']}}, 09:33:17 INFO - 'talos.zip': {'path': '', 09:33:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:17 INFO - Running post-action listener: _resource_record_post_action 09:33:17 INFO - ##### 09:33:17 INFO - ##### Running create-virtualenv step. 09:33:17 INFO - ##### 09:33:17 INFO - Running pre-action listener: _resource_record_pre_action 09:33:17 INFO - Running main action method: create_virtualenv 09:33:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:17 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 09:33:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:17 INFO - Using real prefix '/usr' 09:33:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:20 INFO - Installing pip.................done. 09:33:20 INFO - Return code: 0 09:33:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:20 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')]} 09:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:20 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')]} 09:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:20 INFO - Using env: {'DISPLAY': ':0', 09:33:20 INFO - 'HOME': '/home/cltbld', 09:33:20 INFO - 'LANG': 'en_US.UTF-8', 09:33:20 INFO - 'LANGUAGE': 'en_US:en', 09:33:20 INFO - 'LOGNAME': 'cltbld', 09:33:20 INFO - 'MAIL': '/var/mail/cltbld', 09:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:20 INFO - 'MOZ_NO_REMOTE': '1', 09:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:20 INFO - 'NO_EM_RESTART': '1', 09:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:20 INFO - 'PWD': '/builds/slave/test', 09:33:20 INFO - 'SHELL': '/bin/bash', 09:33:20 INFO - 'SHLVL': '1', 09:33:20 INFO - 'TERM': 'linux', 09:33:20 INFO - 'TMOUT': '86400', 09:33:20 INFO - 'USER': 'cltbld', 09:33:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:20 INFO - '_': '/tools/buildbot/bin/python'} 09:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:20 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 09:33:20 INFO - Cleaning up... 09:33:20 INFO - Return code: 0 09:33:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:33:20 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')]} 09:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:20 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')]} 09:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:20 INFO - Using env: {'DISPLAY': ':0', 09:33:20 INFO - 'HOME': '/home/cltbld', 09:33:20 INFO - 'LANG': 'en_US.UTF-8', 09:33:20 INFO - 'LANGUAGE': 'en_US:en', 09:33:20 INFO - 'LOGNAME': 'cltbld', 09:33:20 INFO - 'MAIL': '/var/mail/cltbld', 09:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:20 INFO - 'MOZ_NO_REMOTE': '1', 09:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:20 INFO - 'NO_EM_RESTART': '1', 09:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:20 INFO - 'PWD': '/builds/slave/test', 09:33:20 INFO - 'SHELL': '/bin/bash', 09:33:20 INFO - 'SHLVL': '1', 09:33:20 INFO - 'TERM': 'linux', 09:33:20 INFO - 'TMOUT': '86400', 09:33:20 INFO - 'USER': 'cltbld', 09:33:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:20 INFO - '_': '/tools/buildbot/bin/python'} 09:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:20 INFO - Downloading/unpacking psutil>=0.7.1 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:20 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 09:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:22 INFO - Installing collected packages: psutil 09:33:22 INFO - Running setup.py install for psutil 09:33:22 INFO - building 'psutil._psutil_linux' extension 09:33:22 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 09:33:23 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 09:33:23 INFO - building 'psutil._psutil_posix' extension 09:33:23 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 09:33:23 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 09:33:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:23 INFO - Successfully installed psutil 09:33:23 INFO - Cleaning up... 09:33:23 INFO - Return code: 0 09:33:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:33:23 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')]} 09:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:23 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')]} 09:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:23 INFO - Using env: {'DISPLAY': ':0', 09:33:23 INFO - 'HOME': '/home/cltbld', 09:33:23 INFO - 'LANG': 'en_US.UTF-8', 09:33:23 INFO - 'LANGUAGE': 'en_US:en', 09:33:23 INFO - 'LOGNAME': 'cltbld', 09:33:23 INFO - 'MAIL': '/var/mail/cltbld', 09:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:23 INFO - 'MOZ_NO_REMOTE': '1', 09:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:23 INFO - 'NO_EM_RESTART': '1', 09:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:23 INFO - 'PWD': '/builds/slave/test', 09:33:23 INFO - 'SHELL': '/bin/bash', 09:33:23 INFO - 'SHLVL': '1', 09:33:23 INFO - 'TERM': 'linux', 09:33:23 INFO - 'TMOUT': '86400', 09:33:23 INFO - 'USER': 'cltbld', 09:33:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:23 INFO - '_': '/tools/buildbot/bin/python'} 09:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:33:23 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 09:33:23 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 09:33:23 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 09:33:23 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 09:33:23 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 09:33:23 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 09:33:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:33:25 INFO - Installing collected packages: mozsystemmonitor 09:33:25 INFO - Running setup.py install for mozsystemmonitor 09:33:25 INFO - Successfully installed mozsystemmonitor 09:33:25 INFO - Cleaning up... 09:33:25 INFO - Return code: 0 09:33:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:25 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')]} 09:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 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')]} 09:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:25 INFO - Using env: {'DISPLAY': ':0', 09:33:25 INFO - 'HOME': '/home/cltbld', 09:33:25 INFO - 'LANG': 'en_US.UTF-8', 09:33:25 INFO - 'LANGUAGE': 'en_US:en', 09:33:25 INFO - 'LOGNAME': 'cltbld', 09:33:25 INFO - 'MAIL': '/var/mail/cltbld', 09:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:25 INFO - 'MOZ_NO_REMOTE': '1', 09:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:25 INFO - 'NO_EM_RESTART': '1', 09:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:25 INFO - 'PWD': '/builds/slave/test', 09:33:25 INFO - 'SHELL': '/bin/bash', 09:33:25 INFO - 'SHLVL': '1', 09:33:25 INFO - 'TERM': 'linux', 09:33:25 INFO - 'TMOUT': '86400', 09:33:25 INFO - 'USER': 'cltbld', 09:33:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:25 INFO - '_': '/tools/buildbot/bin/python'} 09:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:25 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 09:33:25 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 09:33:25 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 09:33:25 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 09:33:25 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 09:33:25 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 09:33:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:27 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 09:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 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 09:33:28 INFO - Downloading docopt-0.6.1.tar.gz 09:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:28 INFO - Running setup.py install for blobuploader 09:33:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:28 INFO - Running setup.py install for requests 09:33:29 INFO - Running setup.py install for docopt 09:33:29 INFO - Successfully installed blobuploader requests docopt 09:33:29 INFO - Cleaning up... 09:33:29 INFO - Return code: 0 09:33:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:29 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')]} 09:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:29 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')]} 09:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 09:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 09:33:29 INFO - Using env: {'DISPLAY': ':0', 09:33:29 INFO - 'HOME': '/home/cltbld', 09:33:29 INFO - 'LANG': 'en_US.UTF-8', 09:33:29 INFO - 'LANGUAGE': 'en_US:en', 09:33:29 INFO - 'LOGNAME': 'cltbld', 09:33:29 INFO - 'MAIL': '/var/mail/cltbld', 09:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:29 INFO - 'MOZ_NO_REMOTE': '1', 09:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:29 INFO - 'NO_EM_RESTART': '1', 09:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:29 INFO - 'PWD': '/builds/slave/test', 09:33:29 INFO - 'SHELL': '/bin/bash', 09:33:29 INFO - 'SHLVL': '1', 09:33:29 INFO - 'TERM': 'linux', 09:33:29 INFO - 'TMOUT': '86400', 09:33:29 INFO - 'USER': 'cltbld', 09:33:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:29 INFO - '_': '/tools/buildbot/bin/python'} 09:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:29 INFO - Running setup.py (path:/tmp/pip-80jGIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:29 INFO - Running setup.py (path:/tmp/pip-J6F6H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:29 INFO - Running setup.py (path:/tmp/pip-m45yY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:29 INFO - Running setup.py (path:/tmp/pip-bNvHNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:29 INFO - Running setup.py (path:/tmp/pip-3EnF5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:29 INFO - Running setup.py (path:/tmp/pip-6Zw9H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:29 INFO - Running setup.py (path:/tmp/pip-n1bOvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:29 INFO - Running setup.py (path:/tmp/pip-psMIjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:29 INFO - Running setup.py (path:/tmp/pip-RZNbjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:30 INFO - Running setup.py (path:/tmp/pip-_FTd0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:30 INFO - Running setup.py (path:/tmp/pip-7VGkWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:30 INFO - Running setup.py (path:/tmp/pip-0bjlu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:30 INFO - Running setup.py (path:/tmp/pip-Zd4Gwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:30 INFO - Running setup.py (path:/tmp/pip-BgiSbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:30 INFO - Running setup.py (path:/tmp/pip-zXQy2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:30 INFO - Running setup.py (path:/tmp/pip-KoY7NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:30 INFO - Running setup.py (path:/tmp/pip-SZ3V78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:30 INFO - Running setup.py install for manifestparser 09:33:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:30 INFO - Running setup.py install for mozcrash 09:33:30 INFO - Running setup.py install for mozdebug 09:33:30 INFO - Running setup.py install for mozdevice 09:33:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozfile 09:33:31 INFO - Running setup.py install for mozhttpd 09:33:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozinfo 09:33:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozInstall 09:33:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozleak 09:33:31 INFO - Running setup.py install for mozlog 09:33:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for moznetwork 09:33:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozprocess 09:33:31 INFO - Running setup.py install for mozprofile 09:33:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:31 INFO - Running setup.py install for mozrunner 09:33:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:32 INFO - Running setup.py install for mozscreenshot 09:33:32 INFO - Running setup.py install for moztest 09:33:32 INFO - Running setup.py install for mozversion 09:33:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:32 INFO - Cleaning up... 09:33:32 INFO - Return code: 0 09:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:32 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')]} 09:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:32 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')]} 09:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:32 INFO - Using env: {'DISPLAY': ':0', 09:33:32 INFO - 'HOME': '/home/cltbld', 09:33:32 INFO - 'LANG': 'en_US.UTF-8', 09:33:32 INFO - 'LANGUAGE': 'en_US:en', 09:33:32 INFO - 'LOGNAME': 'cltbld', 09:33:32 INFO - 'MAIL': '/var/mail/cltbld', 09:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:32 INFO - 'MOZ_NO_REMOTE': '1', 09:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:32 INFO - 'NO_EM_RESTART': '1', 09:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:32 INFO - 'PWD': '/builds/slave/test', 09:33:32 INFO - 'SHELL': '/bin/bash', 09:33:32 INFO - 'SHLVL': '1', 09:33:32 INFO - 'TERM': 'linux', 09:33:32 INFO - 'TMOUT': '86400', 09:33:32 INFO - 'USER': 'cltbld', 09:33:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:32 INFO - '_': '/tools/buildbot/bin/python'} 09:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:32 INFO - Running setup.py (path:/tmp/pip-ZrrrVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:32 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)) 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:32 INFO - Running setup.py (path:/tmp/pip-e5z91a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:32 INFO - Running setup.py (path:/tmp/pip-L3KyOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:32 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)) 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:32 INFO - Running setup.py (path:/tmp/pip-rAF6Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:32 INFO - Running setup.py (path:/tmp/pip-9MKEgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:32 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)) 09:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:33 INFO - Running setup.py (path:/tmp/pip-fqT3_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:33 INFO - Running setup.py (path:/tmp/pip-9o2Js5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:33 INFO - Running setup.py (path:/tmp/pip-KuQz4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:33 INFO - Running setup.py (path:/tmp/pip-ZJJkCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:33 INFO - Running setup.py (path:/tmp/pip-7eHC3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:33 INFO - Running setup.py (path:/tmp/pip-SKZiT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:33 INFO - Running setup.py (path:/tmp/pip-DFfpUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:33 INFO - Running setup.py (path:/tmp/pip-ooRbjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:33 INFO - Running setup.py (path:/tmp/pip-5wAxXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:33 INFO - Running setup.py (path:/tmp/pip-rZXoJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:33 INFO - Running setup.py (path:/tmp/pip-JmJAV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:33 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)) 09:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:33 INFO - Running setup.py (path:/tmp/pip-LwZN1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:33 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)) 09:33:33 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:33 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:33:33 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)) 09:33:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:33 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 09:33:33 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 09:33:33 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 09:33:33 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 09:33:33 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 09:33:33 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 09:33:35 INFO - Downloading blessings-1.6.tar.gz 09:33:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:35 INFO - Installing collected packages: blessings 09:33:35 INFO - Running setup.py install for blessings 09:33:35 INFO - Successfully installed blessings 09:33:35 INFO - Cleaning up... 09:33:36 INFO - Return code: 0 09:33:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:36 INFO - Reading from file tmpfile_stdout 09:33:36 INFO - Current package versions: 09:33:36 INFO - argparse == 1.2.1 09:33:36 INFO - blessings == 1.6 09:33:36 INFO - blobuploader == 1.2.4 09:33:36 INFO - docopt == 0.6.1 09:33:36 INFO - manifestparser == 1.1 09:33:36 INFO - mozInstall == 1.12 09:33:36 INFO - mozcrash == 0.17 09:33:36 INFO - mozdebug == 0.1 09:33:36 INFO - mozdevice == 0.48 09:33:36 INFO - mozfile == 1.2 09:33:36 INFO - mozhttpd == 0.7 09:33:36 INFO - mozinfo == 0.9 09:33:36 INFO - mozleak == 0.1 09:33:36 INFO - mozlog == 3.1 09:33:36 INFO - moznetwork == 0.27 09:33:36 INFO - mozprocess == 0.22 09:33:36 INFO - mozprofile == 0.28 09:33:36 INFO - mozrunner == 6.11 09:33:36 INFO - mozscreenshot == 0.1 09:33:36 INFO - mozsystemmonitor == 0.0 09:33:36 INFO - moztest == 0.7 09:33:36 INFO - mozversion == 1.4 09:33:36 INFO - psutil == 3.1.1 09:33:36 INFO - requests == 1.2.3 09:33:36 INFO - wsgiref == 0.1.2 09:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:36 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')]} 09:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 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')]} 09:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:36 INFO - Using env: {'DISPLAY': ':0', 09:33:36 INFO - 'HOME': '/home/cltbld', 09:33:36 INFO - 'LANG': 'en_US.UTF-8', 09:33:36 INFO - 'LANGUAGE': 'en_US:en', 09:33:36 INFO - 'LOGNAME': 'cltbld', 09:33:36 INFO - 'MAIL': '/var/mail/cltbld', 09:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:36 INFO - 'MOZ_NO_REMOTE': '1', 09:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:36 INFO - 'NO_EM_RESTART': '1', 09:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:36 INFO - 'PWD': '/builds/slave/test', 09:33:36 INFO - 'SHELL': '/bin/bash', 09:33:36 INFO - 'SHLVL': '1', 09:33:36 INFO - 'TERM': 'linux', 09:33:36 INFO - 'TMOUT': '86400', 09:33:36 INFO - 'USER': 'cltbld', 09:33:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:36 INFO - '_': '/tools/buildbot/bin/python'} 09:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 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)) 09:33:36 INFO - Cleaning up... 09:33:36 INFO - Return code: 0 09:33:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:36 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')]} 09:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 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')]} 09:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:36 INFO - Using env: {'DISPLAY': ':0', 09:33:36 INFO - 'HOME': '/home/cltbld', 09:33:36 INFO - 'LANG': 'en_US.UTF-8', 09:33:36 INFO - 'LANGUAGE': 'en_US:en', 09:33:36 INFO - 'LOGNAME': 'cltbld', 09:33:36 INFO - 'MAIL': '/var/mail/cltbld', 09:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:36 INFO - 'MOZ_NO_REMOTE': '1', 09:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:36 INFO - 'NO_EM_RESTART': '1', 09:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:36 INFO - 'PWD': '/builds/slave/test', 09:33:36 INFO - 'SHELL': '/bin/bash', 09:33:36 INFO - 'SHLVL': '1', 09:33:36 INFO - 'TERM': 'linux', 09:33:36 INFO - 'TMOUT': '86400', 09:33:36 INFO - 'USER': 'cltbld', 09:33:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:36 INFO - '_': '/tools/buildbot/bin/python'} 09:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:36 INFO - Downloading/unpacking jsonschema 09:33:36 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 09:33:36 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 09:33:36 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 09:33:36 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 09:33:36 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 09:33:36 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 09:33:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:38 INFO - Downloading/unpacking functools32 (from jsonschema) 09:33:38 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 09:33:38 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 09:33:38 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 09:33:38 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 09:33:38 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 09:33:38 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 09:33:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:38 INFO - warning: no files found matching '*.txt' 09:33:38 INFO - no previously-included directories found matching 'build' 09:33:38 INFO - no previously-included directories found matching 'dist' 09:33:38 INFO - no previously-included directories found matching '.git*' 09:33:38 INFO - Installing collected packages: jsonschema, functools32 09:33:38 INFO - Running setup.py install for functools32 09:33:38 INFO - warning: no files found matching '*.txt' 09:33:38 INFO - no previously-included directories found matching 'build' 09:33:38 INFO - no previously-included directories found matching 'dist' 09:33:38 INFO - no previously-included directories found matching '.git*' 09:33:38 INFO - Successfully installed jsonschema functools32 09:33:38 INFO - Cleaning up... 09:33:39 INFO - Return code: 0 09:33:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:33:39 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')]} 09:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 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')]} 09:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f4cdd932f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, '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': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', '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 09:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 09:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 09:33:39 INFO - Using env: {'DISPLAY': ':0', 09:33:39 INFO - 'HOME': '/home/cltbld', 09:33:39 INFO - 'LANG': 'en_US.UTF-8', 09:33:39 INFO - 'LANGUAGE': 'en_US:en', 09:33:39 INFO - 'LOGNAME': 'cltbld', 09:33:39 INFO - 'MAIL': '/var/mail/cltbld', 09:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:39 INFO - 'MOZ_NO_REMOTE': '1', 09:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:39 INFO - 'NO_EM_RESTART': '1', 09:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:39 INFO - 'PWD': '/builds/slave/test', 09:33:39 INFO - 'SHELL': '/bin/bash', 09:33:39 INFO - 'SHLVL': '1', 09:33:39 INFO - 'TERM': 'linux', 09:33:39 INFO - 'TMOUT': '86400', 09:33:39 INFO - 'USER': 'cltbld', 09:33:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:39 INFO - '_': '/tools/buildbot/bin/python'} 09:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:39 INFO - Downloading/unpacking flake8 09:33:39 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 09:33:39 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 09:33:39 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 09:33:39 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 09:33:39 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 09:33:39 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 09:33:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:33:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:33:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 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 09:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:33:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:42 INFO - no previously-included directories found matching 'docs/_build' 09:33:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:33:42 INFO - Running setup.py install for pep8 09:33:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:33:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:33:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:33:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:33:42 INFO - no previously-included directories found matching 'docs/_build' 09:33:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:33:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:33:42 INFO - Cleaning up... 09:33:42 INFO - Return code: 0 09:33:42 INFO - Running post-action listener: _resource_record_post_action 09:33:42 INFO - Running post-action listener: _start_resource_monitoring 09:33:42 INFO - Starting resource monitoring. 09:33:42 INFO - ##### 09:33:42 INFO - ##### Running install step. 09:33:42 INFO - ##### 09:33:42 INFO - Running pre-action listener: _resource_record_pre_action 09:33:42 INFO - Running main action method: install 09:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:42 INFO - Reading from file tmpfile_stdout 09:33:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:42 INFO - Reading from file tmpfile_stdout 09:33:42 INFO - Output received: 09:33:42 INFO - Usage: mozinstall [options] installer 09:33:42 INFO - Options: 09:33:42 INFO - -h, --help show this help message and exit 09:33:42 INFO - -d DEST, --destination=DEST 09:33:42 INFO - Directory to install application into. [default: 09:33:42 INFO - "/builds/slave/test"] 09:33:42 INFO - --app=APP Application being installed. [default: firefox] 09:33:42 INFO - mkdir: /builds/slave/test/build/application 09:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:33:55 INFO - Reading from file tmpfile_stdout 09:33:55 INFO - Output received: 09:33:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:55 INFO - Running post-action listener: _resource_record_post_action 09:33:55 INFO - ##### 09:33:55 INFO - ##### Running run-tests step. 09:33:55 INFO - ##### 09:33:55 INFO - Running pre-action listener: _resource_record_pre_action 09:33:55 INFO - Running main action method: run_tests 09:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:55 INFO - Python 2.7.3 09:33:55 INFO - Return code: 0 09:33:55 INFO - grabbing minidump binary from tooltool 09:33:55 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')]} 09:33:55 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 0x1b60410>, '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 0x1b61310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b617a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:55 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 09:33:55 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 09:33:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:55 INFO - Return code: 0 09:33:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:33:56 INFO - Return code: 0 09:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:56 INFO - Using env: {'DISPLAY': ':0', 09:33:56 INFO - 'HOME': '/home/cltbld', 09:33:56 INFO - 'LANG': 'en_US.UTF-8', 09:33:56 INFO - 'LANGUAGE': 'en_US:en', 09:33:56 INFO - 'LOGNAME': 'cltbld', 09:33:56 INFO - 'MAIL': '/var/mail/cltbld', 09:33:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:56 INFO - 'MOZ_NO_REMOTE': '1', 09:33:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:56 INFO - 'NO_EM_RESTART': '1', 09:33:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:56 INFO - 'PWD': '/builds/slave/test', 09:33:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:56 INFO - 'SHELL': '/bin/bash', 09:33:56 INFO - 'SHLVL': '1', 09:33:56 INFO - 'TERM': 'linux', 09:33:56 INFO - 'TMOUT': '86400', 09:33:56 INFO - 'USER': 'cltbld', 09:33:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642', 09:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:56 INFO - '_': '/tools/buildbot/bin/python'} 09:33:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:57 INFO - mozversion application_buildid: 20160627064925 09:33:57 INFO - mozversion application_changeset: 34281fb8a330ef0731305992a25bd88c66a8cfe8 09:33:57 INFO - mozversion application_display_name: Firefox 09:33:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:57 INFO - mozversion application_name: Firefox 09:33:57 INFO - mozversion application_remotingname: firefox 09:33:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:33:57 INFO - mozversion application_vendor: Mozilla 09:33:57 INFO - mozversion application_version: 48.0 09:33:57 INFO - mozversion platform_buildid: 20160627064925 09:33:57 INFO - mozversion platform_changeset: 34281fb8a330ef0731305992a25bd88c66a8cfe8 09:33:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:33:57 INFO - mozversion platform_version: 48.0 09:33:57 INFO - using testdate: 1467045237 09:33:57 INFO - actual date: 1467045237 09:33:57 INFO - starting webserver on 'localhost:33965' 09:33:57 INFO - SUITE-START | Running 2 tests 09:33:57 INFO - TEST-START | dromaeo_css 09:33:57 INFO - operating with platform_type : linux_ 09:33:57 INFO - Initialising browser for dromaeo_css test... 09:33:57 INFO - TEST-INFO | started process 13456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaFavg/profile http://localhost:33965/getInfo.html) 09:34:00 INFO - PROCESS | 13456 | 09:34:00 INFO - PROCESS | 13456 | (process:13532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:01 INFO - PROCESS | 13456 | __metrics Screen width/height:1600/1200 09:34:01 INFO - PROCESS | 13456 | colorDepth:24 09:34:01 INFO - PROCESS | 13456 | Browser inner width/height: 1024/697 09:34:01 INFO - PROCESS | 13456 | __metrics 09:34:02 ERROR - PROCESS | 13456 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:34:03 INFO - TEST-INFO | 13456: exit 0 09:34:03 INFO - Browser initialized. 09:34:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:03 INFO - TEST-INFO | started process 13582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTaFavg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:05 INFO - PROCESS | 13582 | 09:34:05 INFO - PROCESS | 13582 | (process:13651): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:34:15 INFO - PROCESS | 13582 | RSS: Main: 150990848 09:34:15 INFO - PROCESS | 13582 | 09:35:04 INFO - PROCESS | 13582 | 1467045304860 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] 09:37:12 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33965/tests/dromaeo/cssquery-ext.html) 09:37:13 INFO - PROCESS | 13582 | RSS: Main: 153726976 09:37:13 INFO - PROCESS | 13582 | 09:40:15 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-ext.html (next: http://localhost:33965/tests/dromaeo/cssquery-jquery.html) 09:40:15 INFO - PROCESS | 13582 | RSS: Main: 153145344 09:40:15 INFO - PROCESS | 13582 | 09:43:17 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33965/tests/dromaeo/cssquery-mootools.html) 09:43:17 INFO - PROCESS | 13582 | RSS: Main: 152604672 09:43:17 INFO - PROCESS | 13582 | 09:46:19 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33965/tests/dromaeo/cssquery-prototype.html) 09:46:20 INFO - PROCESS | 13582 | RSS: Main: 153944064 09:46:20 INFO - PROCESS | 13582 | 09:49:22 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33965/tests/dromaeo/cssquery-yui.html) 09:49:23 INFO - PROCESS | 13582 | RSS: Main: 152719360 09:49:23 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | Cycle 1(1): loaded http://localhost:33965/tests/dromaeo/cssquery-yui.html (next: http://localhost:33965/tests/dromaeo/cssquery-dojo.html) 09:52:25 INFO - PROCESS | 13582 | RSS: Main: 156360704 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | __start_tp_report 09:52:25 INFO - PROCESS | 13582 | _x_x_mozilla_page_load 09:52:25 INFO - PROCESS | 13582 | _x_x_mozilla_page_load_details 09:52:25 INFO - PROCESS | 13582 | |i|pagename|runs| 09:52:25 INFO - PROCESS | 13582 | |0;dojo.html;3256.6254880688716;3338;3370.1069216657575;3414.7438942079334;3417.3165366926605;5467.863303417412;5485.314335708036;5498.80754173604;5503.587230957674;5510.944890551098;5510.614257002011;5539.307586551681;5549.223108764776;5549.667019978794;5564.165375193723;5000.0999820032375;5011.42368627607;5045.243213517965;5060.54455099041;5065.79736810529;5003.524665156822;5070.974645126769;5125.743712814363;5178.404483484391;5207.114790485626;4998.800047998094;5069.087564238435;5071.163258062434;5124.564412024983;5137.280780690688;5044.47033061527;5049.899002019939;5059.06407314648;5061.468545802712;5089.949100508985;4921;4994.675346102492;5043.571296439807;5049.64652474327;5051.090803655341;5311.5750739941095;5380.946190538123;5442.2380866678695;5457.754401051922;5463.371712253102;5890.587658863881;5901.439363260483;5916.704164791743;5918.112283157518;5943.435373639541;5800.216970708942;5957.255343082114;5957.582969192158;5966.67183304918;5979;5548.6948217848;5553.6390134641115;5581.720913954286;5584.636998595079;5592.720363981784;6039.396060394013;6057.515398768088;6073.1497590337385;6075.574709770273;6093.6039157454625;5786.218860453785;5790.131480277992;5816.41835816415;5837.270341207349;5841.620294680833;5884.558658100659;5939.792107276225;5942.524598032147;5946.643201407929;5979.760809567656;5904.232449781501;5908.291005079418;5920.703964801743;5928.79249226275;5934.8813023739285;5714.485696287354;5821.476067153976;5892.469677729025;5909.025010873243;5934.228550288522;4494.9325760113625;4525.63794896414;4538.069695712371;4543.295789152687;4554.977225113853;4077.3068578341754;4078.9796051019557;4113.4446849675505;4117.114820313647;4120.381942708557;5597.74810133545;5674.858128546819;5744.454276843693;5748.48263656273;5756.740946657411;5839.299284085937;5915.763369465173;5994.1608174855555;5996.190514280604;6022.638641681513;5698.943010569924;5699.572532060112;5712.657240565496;5716.628419152742;5723.170140329629;4957.3555437793575;4992.625553083533;5013.874653133701;5030.346055012898;5042.168042272984;6075.574709770273;6112.572119951649;6132.478739307119;6138.263408390932;6142.293636231891;5883.941160588511;6005.159277701126;6010.639361638316;6011.128386384037;6019.488343490677;6083.543734220039;6118.253719382578;6152.538559608137;6156.907646385218;6174.845628859314;5907.202527658711;5907.202527658711;5913.408659134052;5914.083317085859;5926.318473375444;5898.4101589842385;5960.403959604005;6015.218021657157;6020;6023;5794.855128621818;5823.126531020381;5832.591718579659;5835.503982161564;5861.9413805861395;5758.596898217084;5776.56675749312;5797.362290147996;5804.158397032491;5821.98115329824;5539.473749993744;5700.3444603871085;5733.111367738007;5734.770609175586;5836.037053886062;5798.159266906359;5826.446487583673;5830.271216097988;5830.300363956352;5838.3869693683255;5714.285714285715;5714.714264286852;5723.027085395576;5745.109508026263;5755.107958266475 09:52:25 INFO - PROCESS | 13582 | |1;ext.html;667.5927684112694;682.8839097353451;699.7550857199984;730.6091241185967;745.455817253405;39663.80168099159;40587.594124058785;40765.7961710191;40809.795951020205;40871.79564102179;43814.7809260954;44219.33670994938;44323;44411.55588444114;44479.33281000787;8929.330300227477;9088.77278068047;9102.408343457688;9106.362554621179;9108.134727200939;8844.690435834747;8993.910060899405;8997.190252877239;8997.595108220146;9014.053524379944;9297.953510232439;9330.346875718702;9351.205147562465;9354.251659867194;9412.152906238438;9218.953905230464;9273.397229180115;9281.118293762082;9323.627054917795;9330.253579713606;9191.678291259841;9281.489518076503;9306.976232614406;9325.720228393158;9331.486768227745;43458;43612;43734.781326093165;43862.56137438617;43959;4169.666426685858;4179.03882107114;4202.6847986400835;4349.282368409209;4753.643476739258;33483;33853.15367115817;34511;34558.30883382344;35046.64953350459;4589.265717485219;4615.95384046162;4653.511381304982;4692.460367057798;4704.411948506437;248350;248353;248628.75685621638;248992;251154;63438.68280658659;63597;63813;63815.40461488407;63853.36146638567;66999.66500167566;71260;72462;72472;72537;18882.81117188838;18989.240430382906;19161.808381916002;19172.041397930047;19233.61532769365;13567;13630.522931697344;13639.931800341134;13645.795313070312;13655.863441365658;21012.894935525226;21178.576428471344;21276.255331063338;21292.574148516942;21313.147474101173;7691.923080769233;7770;7808.7657370278985;7840.41196910234;8026.558539280279;1096.857408536885;1109.7614012987246;1149.770045990805;1162.3026184289358;1191.2495128069434;28746.712532874823;29347;29373;29920.85039574832;30079.548806767914;1244.595506460404;1248.8813562711528;1331.467413034794;1350.8108864758942;1369.8082268482422;15516.836237282248;16516.42192523256;16664.917829643393;16729.16354182286;16865.494035178963;509639;884922;886392;895749;908893;63564.68217658975;64334;64348.356516435175;64512.354876450634;64924.675376622814;1461.7295800276984;1531.257340190007;1539.3226980128932;1543.436645624339;1550.6976139652659;33110.5033424494;33330;33603.49594756032;33705.83147084249;34431.311373772885;54890.451095490134;55191.17213241724;55236;55631.16553251785;55719.72140139274;426809;430011;431208;432597;433035;45531;46345.30482042839;46383.304250436944;46446;46566;51062.74468627633;51609.74195129;52484;52582.73708631432;53717.46282537124;39997.40003899886;41981.580184197766;42434;42894.14211715811;43962.78018609886;43101;44802;48795.5120448791;48952.75523622359;49542;42684.78657606692;42856.78571607122;43067.7846610765;43183.568164317956;43722.781386092865;36900.630993689716;37025.444618330206;37181.62818371782;37715.62284377121;37733.4339984906;29520;29610.259743506584;29661.258468537595;29962.501874906604;30396.696033040273 09:52:25 INFO - PROCESS | 13582 | |2;jquery.html;376.44098513707155;379.96960243180513;392.23122679548084;396.33020195868977;396.82143035633953;18486.630267394645;20744.688829667568;21290.254841080565;21338.146474141035;21392.144314227433;19788.802111978875;20381.28665496708;20535.486612834688;20541.897290513527;20776.168953241853;5782.161586569945;5951.345352011286;5977.073553599199;5986.700664966756;6003.7898673546215;5834.124881267801;6106.328303886569;6112.235970503687;6113.816585502442;6123.050927106306;6051.576389652704;6052.788152414666;6057.757689692407;6072;6457.709403076849;6636.270010298863;6765;6766.086578311914;6790.932090679079;6804.48966327525;5991.131285963511;6040.486558642477;6055.2430946131735;6075.848103797396;6080.179175811298;22781.54436911269;22947.770522294897;23542.52914941709;24125;24149.758502414927;2465.1248806673552;2478.0459523083564;2535.0620270500035;2615.0716495643965;2836.517791975369;10025.699229023141;10500.2649814513;10546.156307495383;10729.927007299286;10855.51150198243;2028.4827369020952;2060.1553363121047;2082.1046949811575;2111.714918486;2171.4137182960512;81740.59129704373;82936.58531707303;85807.57096214542;86045.13954860433;87349;11330.716732081764;11502.677192123014;11602;11621.302721836717;11725.472353744102;16664.583385415463;16687.249073791707;16693.248803803857;16719.49841504757;16730.6653866922;8842.867356989651;9098.090190980849;9133.315001374924;9136.954315228515;9291;9084.137006984325;9086.000539940602;9149.268058555299;9232.399894007003;9235.399699019543;5013.298138260647;5043.84868453947;5086.237064440364;5120.897582048338;5195.532402083831;2013.9395818125479;2082.4065141434617;2099.559092590573;2117.3965419855267;2138.0223293453805;944.3436811416;962.8170647576937;1001.399160503692;1078.2775540387959;1083.236318395545;18625.348112816257;18786.342478013477;19163.904180479007;19187.616247675247;19283.22867085301;1066.6959916423782;1069.4225118435957;1079.6976846482996;1080.6433876820631;1098.7804634637987;10393.53229104692;10932.945335273433;10962.177836662122;11014.371341092436;11155.442227888572;518373;525089;528154;534741;545126;85067;94790.52604736932;97279;101166.49416753017;102334.48832755937;1134.9943250283861;1145.3814939932342;1161.6863446869297;1183.065378351093;1202.3747651221315;17230.310787568356;17676.20457079409;17703.73444398361;17710;17785.911070444567;39693.2061358777;40294.19411611693;40499.797501012305;41067.383989240785;41203.38194927019;58479.4152058474;60354;60596.39403605908;61975.6901215491;62048.37951620426;8598.140185981352;8672.176143266379;8703.129687031245;8747.343949203709;8782.385233033627;11593.768124637629;12587.685307867376;13063.281519516519;13395.464181432633;13707.314634268047;6231.501479881689;9243.676471323472;11827;11967.880321196677;11996.520139194683;11426;11440.82838757436;11546.59586914454;11727;11790;6501.73993040292;10057.692499975248;10471.3193642413;10794.136469082612;12387.75224495487;8758.255548278214;8787.472751634923;8863.911360886308;8866.379353445196;8941;10997.890021100007;11539.88460115388;11755.88244117548;11853.466594003117;11955.282683039046 09:52:25 INFO - PROCESS | 13582 | |3;mootools.html;1556.0896875327935;1560.6644571417144;1824.2064701854695;1928.7685477742673;1959.1975382647954;7487.25127487251;7926;8315.83368332633;8565;8567.700130495426;8293.958530207356;8323.084460709317;8398.664053437855;8404.62179201936;8405.705800296992;2186.4752459409788;2213;2215.523662412581;2216.4569680428317;2218.223621732397;2307;2384.237044145874;2406.927792166229;2411.1801987324307;2413.78275955164;2415.6497307890345;2430.404550885036;2440.1093600835657;2453.374389530667;2457.2382561405934;2332.0671731307443;2339.4502291961376;2342.3090188394463;2351.71779386473;2393.210240620591;2376.4771750214927;2379.262428647125;2405.025964484369;2405.807535397164;2413.5776239158076;8535.061143274235;8540.103289154673;8573.485590864506;8575.699850505265;8602.225799678059;5273.367195936512;5351.678899266057;5401.081816091274;5401.378841433247;5444.591655625804;3426.2804810989724;3428.879989200391;3496.8776092836883;3510.1049232445816;3523.4362501999813;1093.4040947683532;1105.3257512917114;1115.1023426141953;1129.4409267412602;1153.1870031627766;12190.695232619168;12227.449764760608;12228.327441990687;12236.265824050586;12246.387680615933;4428.512863585003;4533.77331133442;4596.747178905125;4624.121416930772;4625.537446255415;10254.128399086012;10260.794784104277;10284.845727314096;10290.176785857113;10315.793684126425;5209.114450543341;5253.605979551549;5262.421133675292;5265.657732247391;5271.604629652791;4753.453352864396;4819.987802561432;4851.80592776285;4887.0714564232685;4900.387451568554;3777.1690228149764;3797.6202379761803;3839.6928245740833;3844.0774214188395;3868.787216703052;1068.71144790906;1071.6356438810685;1082.4520935062778;1085.1264731890747;1160.2980196980873;956.5743244256379;1012.4178597306578;1048.1614708233535;1057.1384321777728;1064.6433444795925;5818.069108942549;6014.548908831855;6066.423689749467;6070.666113363807;6301.306856245809;1016.5120742043861;1063.3035361838008;1073.0985971783582;1082.4533610526792;1083.6478144603036;4109.506859176918;4156.43888075112;4159.875203743832;4162.396452514368;4181.351890456984;9948.502574871227;10231.232657550714;10308.072273495422;10323.793524129474;10330.070293673605;10065.647702330383;10130.138938190188;10140.645077422254;10164.796704066026;10179.338343007681;7781.92218077812;8053.1141574426765;8068.07217170033;8172.713955011546;8258.504489730516;6019.548533860066;6185.2886918003205;6324.873502529832;6350.396712312323;6386.265579458422;9415.62337506492;9496.717943077596;9505.28710346713;9619.903800961902;9663.855042174513;9319.720408387759;9539.856902146612;9682.75793105178;9874.40753554789;9918.355306905316;7374.188839227788;7526.473146879666;7556.622168891643;7727.304542591194;7894.6842126314305;7934.6826126956585;7951.562664053533;7976.322012628992;8012.639431225725;8014.919850801417;7251.601161935933;7361.779146625609;7390.482666213528;7514.39884809203;7553.584552849646;7228.31331023552;7263.418926485974;7268.418526517971;7275.490715649854;7300.96349518249;6749.662516874235;6773.322667733384;6789.796306110825;6821.761238356634;6852.040714300102;5169.896602068013;5186.611004174627;5216.035033518811;5269.657472264291;5278.208268759717;5306.310179676618;5356.544693701079;5410.836670115944;5522.751476183662;5525.889482210253 09:52:25 INFO - PROCESS | 13582 | |4;prototype.html;337.1049862614757;337.54431517451445;341.56279961649096;342.761780562509;345.88931541906567;6309.1482649842255;6370.394812492812;6451.483881289498;6464.159659244292;6477.157969463963;6334.049892516125;6355.5233357498255;6356.809295721136;6370.394812492817;6389.137466442029;4641.327007583898;4784.760761961906;4800.087983283182;4819.156647586676;4827.879303017417;4767.380240568738;4789.712617242959;4798.208295631217;4808.807647694106;4810.567048965592;4744.240921452569;4756.35789168463;4756.5243475652505;4767.356406885078;4770.666053376265;4760.452547956995;4765.189917713997;4768.73771942543;4779.522047795227;4789.712617242976;4123.958760412387;4131.380292956051;4132.049628585412;4142.171565686845;4150.190712811003;5959;6092.634441933498;6153.384661533811;6160.414760597736;6162;5542.667439953616;5572.58205634579;5574.777008919638;5586.301712285965;5589;6800.761973330909;6832.59004459734;6839.658017099126;6841.2132604750595;6858.759943401957;4544.909101817978;4569.817207311704;4575.4051973243595;4577.656675749332;4585.174668559658;7043.718251269943;7112.004319395289;7113.288671132897;7114.822129446805;7125.038119853805;4509.2559727644575;4641.234196357631;4673.088747694167;4675.555822196886;4678.064387122521;4696.718196908197;4708.81164753406;4719.83480578185;4728.40894888139;4748.430188377417;5514.338279406497;5525.557955363642;5527.861803454945;5531.723413829292;5554.91667624986;6818.147731533559;6826.180858297036;6828.52200345981;6839.879637312449;6857.314268573203;1645.9670806583802;1665.900045997244;1670.6491636756175;1671.456776547627;1673.564873132994;1013.7646489490655;1056.9682909512726;1064.6593090211213;1066.0831684751108;1066.9786604267872;6572.11276477679;6602.108715323466;6606.504512161607;6622.966885165543;6637.137172167587;7046.894296585555;7056.223815380304;7061.258567850405;7067.081279433641;7067.081279433641;6510.446612037935;6627.834304142339;6659.167604049494;6660.933390666129;6712.798616041527;3798.1264309209037;3829.525632631401;3833.290841194388;3834.175652234783;3853.2100919311474;7229;7286.089238845145;7305.926940730631;7314.561126332437;7325.816854578678;7174.533655312493;7174.892376614355;7180.964095179491;7201.89197162043;7245.492815502864;7137.92862071383;7349.669264883093;7365.447591430664;7367.81580460482;7368.778936631802;7099.432045436456;7129;7133;7135.82160445993;7140.107486564179;7006.404455621126;7016.719331226694;7024.192217895007;7024.227334993045;7034.718611255493;7201.2438693938475;7334.413246940126;7351.338379545867;7353.7058517660835;7360.631968401452;4619.838305659286;4660.347551342747;4666.0434610904;4670.346151538719;4677.438707355003;7057.364837164474;7085.539439936388;7085.9645701773225;7112.57324560528;7116.718990581745;6815.522913396213;6847.794566163023;6857.27998560164;6864.7940561783225;6874.896876546756;6827.48793840454;6841.21326047491;6851.45188384938;6855.897161542481;6864.5881247125335;6473.676316184266;6609.504287178577;6714.798556043326;6746.797596072126;6750.5274630775375;6882.623475304859;6897.517173797786;6905.75829845953;6905.792826215222;6912.101426814482;6723.966380168068;6752.08846805675;6755.324467553205;6757.729690812509;6759.628220447923 09:52:25 INFO - PROCESS | 13582 | |5;yui.html;787.8936343593613;812.8536863364595;878.8925953298842;894.9320148331271;908.1826356279348;15459.45891893784;15701.842981570195;15777.921110394433;15866.920665396672;15875.68248635028;13376.799348009788;13449.798253026212;13601.52394666187;13865.237411942364;13950.372233249504;909.9545022748853;917.3486824354716;940.1679513630418;941.1200527506769;941.1341565759518;933.0855761353878;933.3932943586655;934.5747684803398;934.8784657994452;936.9390989585689;980.2452111873853;983.9754006149868;984.4044353166339;985.9852102218473;986.6793292180071;970.0929630795193;972.7811242470458;974.5663179884954;976.4043933200742;976.9804603907918;721.4120491799167;723.8443734597034;728.1044315491922;729.9671514781794;731.5610633619785;15353.616159595987;15443.382264709398;15471.922640386838;15509.22453877313;15626.453074142464;14561.635959101;14713.190774507399;14715.55853324402;14748.778768318483;14777.926110369486;12116.878831211663;12328.1986670867;12352.07359448045;12411.193272437262;12547.24716517012;3997.5402828674783;4020.3165461871554;4068.328725760246;4169.770662613555;4186.832526698959;57659;58117.99999999958;58464.41535584632;60795.39204607942;61931;10425.9478702606;10530.15758739299;10537.15702743794;10568.947155264175;10674.519646615921;19736.90131549333;19771.209151633775;19957.700634490495;20084.196632134845;20089.296874609317;8515.403921725543;8550;8643.870341944876;8679.783005424788;8912.37613367071;4601.171789077931;4643.257078867365;4754.07295577366;4933.703977761345;5068.56917162038;3537.4693795930816;3572.1962558424148;3580.373434648926;3585.354636165463;3593.9281214376088;658.96375699337;660.8083655739878;668.2181847238743;679.755288096285;680.4488364424832;810.5136917849361;828.0973738624928;829.4152622401193;841.1252297610539;845.7335939179139;8760.976194519528;9135.680251191176;9144.131307525775;9159.725208243763;9201.07989201088;640.4396153365805;651.6611362091686;665.8102440804347;731.9011933389031;736.3078706016328;4591.265397536378;4672.883177920579;4718.646101542329;4745.810167593327;4786.8085276588545;58512.707436462544;58580.41419585835;61466;72271;72394;57418;57651.711741441024;57882.131768023515;59163.40836591665;59539.40460595339;50528.242076368886;51435.7428212864;51896;53919;54691.179632305546;10296.279260451996;10335.638252661121;10434.739131521772;10549.525271362654;10563.20775941792;39735.602643974344;40410.59589404186;40723;41222.58777412187;41737.791311044464;47028;47826;55085.724571376886;55147.44852551423;56182.71908640431;12713.682157946125;12889.162204456681;12970.35148242603;13076.346182691017;13162.934185329012;14732.926335368255;14885.106893585986;15031.398744050115;15095.849041509444;15418.691626167189;13238;13547.729045418839;13765.587032389045;13955.302234888011;14151.929240353733;13391.397387117408;13514.864851351755;13732.382042808298;13780.517681881087;13806.240656763974;13423.127496712683;13561.796573051215;13618.727625447635;14026;14340.784888226477;11211.383373914186;11366.204365694322;11435.485403156712;11625.709357266136;11995.280283183038;11692.88307116952;11833.82249266279;11914.16600837933;12132.818007730068;12189.451474683483 09:52:25 INFO - PROCESS | 13582 | __end_tp_report 09:52:25 INFO - PROCESS | 13582 | __start_cc_report 09:52:25 INFO - PROCESS | 13582 | _x_x_mozilla_cycle_collect,325 09:52:25 INFO - PROCESS | 13582 | __end_cc_report 09:52:25 INFO - PROCESS | 13582 | __startTimestamp1467046345637__endTimestamp 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | ------- Summary: start ------- 09:52:25 INFO - PROCESS | 13582 | Number of tests: 6 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#0] dojo.html Cycles:165 Average:5520.02 Median:5748.48 stddev:608.41 (10.6%) stddev-sans-first:583.80 09:52:25 INFO - PROCESS | 13582 | Values: 3256.6 3338.0 3370.1 3414.7 3417.3 5467.9 5485.3 5498.8 5503.6 5510.9 5510.6 5539.3 5549.2 5549.7 5564.2 5000.1 5011.4 5045.2 5060.5 5065.8 5003.5 5071.0 5125.7 5178.4 5207.1 4998.8 5069.1 5071.2 5124.6 5137.3 5044.5 5049.9 5059.1 5061.5 5089.9 4921.0 4994.7 5043.6 5049.6 5051.1 5311.6 5380.9 5442.2 5457.8 5463.4 5890.6 5901.4 5916.7 5918.1 5943.4 5800.2 5957.3 5957.6 5966.7 5979.0 5548.7 5553.6 5581.7 5584.6 5592.7 6039.4 6057.5 6073.1 6075.6 6093.6 5786.2 5790.1 5816.4 5837.3 5841.6 5884.6 5939.8 5942.5 5946.6 5979.8 5904.2 5908.3 5920.7 5928.8 5934.9 5714.5 5821.5 5892.5 5909.0 5934.2 4494.9 4525.6 4538.1 4543.3 4555.0 4077.3 4079.0 4113.4 4117.1 4120.4 5597.7 5674.9 5744.5 5748.5 5756.7 5839.3 5915.8 5994.2 5996.2 6022.6 5698.9 5699.6 5712.7 5716.6 5723.2 4957.4 4992.6 5013.9 5030.3 5042.2 6075.6 6112.6 6132.5 6138.3 6142.3 5883.9 6005.2 6010.6 6011.1 6019.5 6083.5 6118.3 6152.5 6156.9 6174.8 5907.2 5907.2 5913.4 5914.1 5926.3 5898.4 5960.4 6015.2 6020.0 6023.0 5794.9 5823.1 5832.6 5835.5 5861.9 5758.6 5776.6 5797.4 5804.2 5822.0 5539.5 5700.3 5733.1 5734.8 5836.0 5798.2 5826.4 5830.3 5830.3 5838.4 5714.3 5714.7 5723.0 5745.1 5755.1 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#1] ext.html Cycles:180 Average:67036.75 Median:43728.78 stddev:151070.30 (345.5%) stddev-sans-first:151411.91 09:52:25 INFO - PROCESS | 13582 | Values: 667.6 682.9 699.8 730.6 745.5 39663.8 40587.6 40765.8 40809.8 40871.8 43814.8 44219.3 44323.0 44411.6 44479.3 8929.3 9088.8 9102.4 9106.4 9108.1 8844.7 8993.9 8997.2 8997.6 9014.1 9298.0 9330.3 9351.2 9354.3 9412.2 9219.0 9273.4 9281.1 9323.6 9330.3 9191.7 9281.5 9307.0 9325.7 9331.5 43458.0 43612.0 43734.8 43862.6 43959.0 4169.7 4179.0 4202.7 4349.3 4753.6 33483.0 33853.2 34511.0 34558.3 35046.6 4589.3 4616.0 4653.5 4692.5 4704.4 248350.0 248353.0 248628.8 248992.0 251154.0 63438.7 63597.0 63813.0 63815.4 63853.4 66999.7 71260.0 72462.0 72472.0 72537.0 18882.8 18989.2 19161.8 19172.0 19233.6 13567.0 13630.5 13639.9 13645.8 13655.9 21012.9 21178.6 21276.3 21292.6 21313.1 7691.9 7770.0 7808.8 7840.4 8026.6 1096.9 1109.8 1149.8 1162.3 1191.2 28746.7 29347.0 29373.0 29920.9 30079.5 1244.6 1248.9 1331.5 1350.8 1369.8 15516.8 16516.4 16664.9 16729.2 16865.5 509639.0 884922.0 886392.0 895749.0 908893.0 63564.7 64334.0 64348.4 64512.4 64924.7 1461.7 1531.3 1539.3 1543.4 1550.7 33110.5 33330.0 33603.5 33705.8 34431.3 54890.5 55191.2 55236.0 55631.2 55719.7 426809.0 430011.0 431208.0 432597.0 433035.0 45531.0 46345.3 46383.3 46446.0 46566.0 51062.7 51609.7 52484.0 52582.7 53717.5 39997.4 41981.6 42434.0 42894.1 43962.8 43101.0 44802.0 48795.5 48952.8 49542.0 42684.8 42856.8 43067.8 43183.6 43722.8 36900.6 37025.4 37181.6 37715.6 37733.4 29520.0 29610.3 29661.3 29962.5 30396.7 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#2] jquery.html Cycles:180 Average:30609.26 Median:24137.38 stddev:87371.07 (362.0%) stddev-sans-first:87586.68 09:52:25 INFO - PROCESS | 13582 | Values: 376.4 380.0 392.2 396.3 396.8 18486.6 20744.7 21290.3 21338.1 21392.1 19788.8 20381.3 20535.5 20541.9 20776.2 5782.2 5951.3 5977.1 5986.7 6003.8 5834.1 6106.3 6112.2 6113.8 6123.1 6051.6 6052.8 6057.8 6072.0 6457.7 6636.3 6765.0 6766.1 6790.9 6804.5 5991.1 6040.5 6055.2 6075.8 6080.2 22781.5 22947.8 23542.5 24125.0 24149.8 2465.1 2478.0 2535.1 2615.1 2836.5 10025.7 10500.3 10546.2 10729.9 10855.5 2028.5 2060.2 2082.1 2111.7 2171.4 81740.6 82936.6 85807.6 86045.1 87349.0 11330.7 11502.7 11602.0 11621.3 11725.5 16664.6 16687.2 16693.2 16719.5 16730.7 8842.9 9098.1 9133.3 9137.0 9291.0 9084.1 9086.0 9149.3 9232.4 9235.4 5013.3 5043.8 5086.2 5120.9 5195.5 2013.9 2082.4 2099.6 2117.4 2138.0 944.3 962.8 1001.4 1078.3 1083.2 18625.3 18786.3 19163.9 19187.6 19283.2 1066.7 1069.4 1079.7 1080.6 1098.8 10393.5 10932.9 10962.2 11014.4 11155.4 518373.0 525089.0 528154.0 534741.0 545126.0 85067.0 94790.5 97279.0 101166.5 102334.5 1135.0 1145.4 1161.7 1183.1 1202.4 17230.3 17676.2 17703.7 17710.0 17785.9 39693.2 40294.2 40499.8 41067.4 41203.4 58479.4 60354.0 60596.4 61975.7 62048.4 8598.1 8672.2 8703.1 8747.3 8782.4 11593.8 12587.7 13063.3 13395.5 13707.3 6231.5 9243.7 11827.0 11967.9 11996.5 11426.0 11440.8 11546.6 11727.0 11790.0 6501.7 10057.7 10471.3 10794.1 12387.8 8758.3 8787.5 8863.9 8866.4 8941.0 10997.9 11539.9 11755.9 11853.5 11955.3 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#3] mootools.html Cycles:180 Average:5683.81 Median:4869.44 stddev:3117.82 (64.0%) stddev-sans-first:3111.13 09:52:25 INFO - PROCESS | 13582 | Values: 1556.1 1560.7 1824.2 1928.8 1959.2 7487.3 7926.0 8315.8 8565.0 8567.7 8294.0 8323.1 8398.7 8404.6 8405.7 2186.5 2213.0 2215.5 2216.5 2218.2 2307.0 2384.2 2406.9 2411.2 2413.8 2415.6 2430.4 2440.1 2453.4 2457.2 2332.1 2339.5 2342.3 2351.7 2393.2 2376.5 2379.3 2405.0 2405.8 2413.6 8535.1 8540.1 8573.5 8575.7 8602.2 5273.4 5351.7 5401.1 5401.4 5444.6 3426.3 3428.9 3496.9 3510.1 3523.4 1093.4 1105.3 1115.1 1129.4 1153.2 12190.7 12227.4 12228.3 12236.3 12246.4 4428.5 4533.8 4596.7 4624.1 4625.5 10254.1 10260.8 10284.8 10290.2 10315.8 5209.1 5253.6 5262.4 5265.7 5271.6 4753.5 4820.0 4851.8 4887.1 4900.4 3777.2 3797.6 3839.7 3844.1 3868.8 1068.7 1071.6 1082.5 1085.1 1160.3 956.6 1012.4 1048.2 1057.1 1064.6 5818.1 6014.5 6066.4 6070.7 6301.3 1016.5 1063.3 1073.1 1082.5 1083.6 4109.5 4156.4 4159.9 4162.4 4181.4 9948.5 10231.2 10308.1 10323.8 10330.1 10065.6 10130.1 10140.6 10164.8 10179.3 7781.9 8053.1 8068.1 8172.7 8258.5 6019.5 6185.3 6324.9 6350.4 6386.3 9415.6 9496.7 9505.3 9619.9 9663.9 9319.7 9539.9 9682.8 9874.4 9918.4 7374.2 7526.5 7556.6 7727.3 7894.7 7934.7 7951.6 7976.3 8012.6 8014.9 7251.6 7361.8 7390.5 7514.4 7553.6 7228.3 7263.4 7268.4 7275.5 7301.0 6749.7 6773.3 6789.8 6821.8 6852.0 5169.9 5186.6 5216.0 5269.7 5278.2 5306.3 5356.5 5410.8 5522.8 5525.9 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#4] prototype.html Cycles:180 Average:5670.73 Median:6493.80 stddev:1764.89 (27.2%) stddev-sans-first:1723.84 09:52:25 INFO - PROCESS | 13582 | Values: 337.1 337.5 341.6 342.8 345.9 6309.1 6370.4 6451.5 6464.2 6477.2 6334.0 6355.5 6356.8 6370.4 6389.1 4641.3 4784.8 4800.1 4819.2 4827.9 4767.4 4789.7 4798.2 4808.8 4810.6 4744.2 4756.4 4756.5 4767.4 4770.7 4760.5 4765.2 4768.7 4779.5 4789.7 4124.0 4131.4 4132.0 4142.2 4150.2 5959.0 6092.6 6153.4 6160.4 6162.0 5542.7 5572.6 5574.8 5586.3 5589.0 6800.8 6832.6 6839.7 6841.2 6858.8 4544.9 4569.8 4575.4 4577.7 4585.2 7043.7 7112.0 7113.3 7114.8 7125.0 4509.3 4641.2 4673.1 4675.6 4678.1 4696.7 4708.8 4719.8 4728.4 4748.4 5514.3 5525.6 5527.9 5531.7 5554.9 6818.1 6826.2 6828.5 6839.9 6857.3 1646.0 1665.9 1670.6 1671.5 1673.6 1013.8 1057.0 1064.7 1066.1 1067.0 6572.1 6602.1 6606.5 6623.0 6637.1 7046.9 7056.2 7061.3 7067.1 7067.1 6510.4 6627.8 6659.2 6660.9 6712.8 3798.1 3829.5 3833.3 3834.2 3853.2 7229.0 7286.1 7305.9 7314.6 7325.8 7174.5 7174.9 7181.0 7201.9 7245.5 7137.9 7349.7 7365.4 7367.8 7368.8 7099.4 7129.0 7133.0 7135.8 7140.1 7006.4 7016.7 7024.2 7024.2 7034.7 7201.2 7334.4 7351.3 7353.7 7360.6 4619.8 4660.3 4666.0 4670.3 4677.4 7057.4 7085.5 7086.0 7112.6 7116.7 6815.5 6847.8 6857.3 6864.8 6874.9 6827.5 6841.2 6851.5 6855.9 6864.6 6473.7 6609.5 6714.8 6746.8 6750.5 6882.6 6897.5 6905.8 6905.8 6912.1 6724.0 6752.1 6755.3 6757.7 6759.6 09:52:25 INFO - PROCESS | 13582 | 09:52:25 INFO - PROCESS | 13582 | [#5] yui.html Cycles:180 Average:15996.09 Median:4596.22 stddev:18491.94 (402.3%) stddev-sans-first:18508.55 09:52:25 INFO - PROCESS | 13582 | Values: 787.9 812.9 878.9 894.9 908.2 15459.5 15701.8 15777.9 15866.9 15875.7 13376.8 13449.8 13601.5 13865.2 13950.4 910.0 917.3 940.2 941.1 941.1 933.1 933.4 934.6 934.9 936.9 980.2 984.0 984.4 986.0 986.7 970.1 972.8 974.6 976.4 977.0 721.4 723.8 728.1 730.0 731.6 15353.6 15443.4 15471.9 15509.2 15626.5 14561.6 14713.2 14715.6 14748.8 14777.9 12116.9 12328.2 12352.1 12411.2 12547.2 3997.5 4020.3 4068.3 4169.8 4186.8 57659.0 58118.0 58464.4 60795.4 61931.0 10425.9 10530.2 10537.2 10568.9 10674.5 19736.9 19771.2 19957.7 20084.2 20089.3 8515.4 8550.0 8643.9 8679.8 8912.4 4601.2 4643.3 4754.1 4933.7 5068.6 3537.5 3572.2 3580.4 3585.4 3593.9 659.0 660.8 668.2 679.8 680.4 810.5 828.1 829.4 841.1 845.7 8761.0 9135.7 9144.1 9159.7 9201.1 640.4 651.7 665.8 731.9 736.3 4591.3 4672.9 4718.6 4745.8 4786.8 58512.7 58580.4 61466.0 72271.0 72394.0 57418.0 57651.7 57882.1 59163.4 59539.4 50528.2 51435.7 51896.0 53919.0 54691.2 10296.3 10335.6 10434.7 10549.5 10563.2 39735.6 40410.6 40723.0 41222.6 41737.8 47028.0 47826.0 55085.7 55147.4 56182.7 12713.7 12889.2 12970.4 13076.3 13162.9 14732.9 14885.1 15031.4 15095.8 15418.7 13238.0 13547.7 13765.6 13955.3 14151.9 13391.4 13514.9 13732.4 13780.5 13806.2 13423.1 13561.8 13618.7 14026.0 14340.8 11211.4 11366.2 11435.5 11625.7 11995.3 11692.9 11833.8 11914.2 12132.8 12189.5 09:52:25 INFO - PROCESS | 13582 | -------- Summary: end -------- 09:52:25 INFO - PROCESS | 13582 | 09:52:26 INFO - TEST-INFO | 13582: exit 0 09:52:26 INFO - TEST-OK | dromaeo_css | took 1109247ms 09:52:26 INFO - TEST-START | kraken 09:52:26 INFO - operating with platform_type : linux_ 09:52:26 INFO - Initialising browser for kraken test... 09:52:26 INFO - TEST-INFO | started process 13823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphAYQsk/profile http://localhost:33965/getInfo.html) 09:52:30 INFO - PROCESS | 13823 | 09:52:30 INFO - PROCESS | 13823 | (process:13902): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:30 INFO - PROCESS | 13823 | __metrics Screen width/height:1600/1200 09:52:30 INFO - PROCESS | 13823 | colorDepth:24 09:52:30 INFO - PROCESS | 13823 | Browser inner width/height: 1024/697 09:52:30 INFO - PROCESS | 13823 | __metrics 09:52:31 ERROR - PROCESS | 13823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:52:32 INFO - TEST-INFO | 13823: exit 0 09:52:32 INFO - Browser initialized. 09:52:32 INFO - Running cycle 1/1 for kraken test... 09:52:32 INFO - TEST-INFO | started process 13952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphAYQsk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:34 INFO - PROCESS | 13952 | 09:52:34 INFO - PROCESS | 13952 | (process:14020): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:52:44 INFO - PROCESS | 13952 | RSS: Main: 150806528 09:52:44 INFO - PROCESS | 13952 | 09:52:46 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33965/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:47 INFO - PROCESS | 13952 | RSS: Main: 156274688 09:52:47 INFO - PROCESS | 13952 | 09:52:50 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33965/tests/kraken/driver.html?testName=audio-dft) 09:52:50 INFO - PROCESS | 13952 | RSS: Main: 156061696 09:52:50 INFO - PROCESS | 13952 | 09:52:53 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33965/tests/kraken/driver.html?testName=audio-fft) 09:52:54 INFO - PROCESS | 13952 | RSS: Main: 156454912 09:52:54 INFO - PROCESS | 13952 | 09:52:56 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33965/tests/kraken/driver.html?testName=audio-oscillator) 09:52:56 INFO - PROCESS | 13952 | RSS: Main: 155791360 09:52:56 INFO - PROCESS | 13952 | 09:52:59 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33965/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:59 INFO - PROCESS | 13952 | RSS: Main: 155881472 09:52:59 INFO - PROCESS | 13952 | 09:53:02 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33965/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:03 INFO - PROCESS | 13952 | RSS: Main: 156151808 09:53:03 INFO - PROCESS | 13952 | 09:53:06 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33965/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:07 INFO - PROCESS | 13952 | RSS: Main: 156262400 09:53:07 INFO - PROCESS | 13952 | 09:53:09 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33965/tests/kraken/driver.html?testName=json-parse-financial) 09:53:10 INFO - PROCESS | 13952 | RSS: Main: 155893760 09:53:10 INFO - PROCESS | 13952 | 09:53:12 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33965/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:12 INFO - PROCESS | 13952 | RSS: Main: 156426240 09:53:12 INFO - PROCESS | 13952 | 09:53:14 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:15 INFO - PROCESS | 13952 | RSS: Main: 156151808 09:53:15 INFO - PROCESS | 13952 | 09:53:17 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:17 INFO - PROCESS | 13952 | RSS: Main: 156442624 09:53:17 INFO - PROCESS | 13952 | 09:53:20 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:20 INFO - PROCESS | 13952 | RSS: Main: 157061120 09:53:20 INFO - PROCESS | 13952 | 09:53:23 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:24 INFO - PROCESS | 13952 | RSS: Main: 156774400 09:53:24 INFO - PROCESS | 13952 | 09:53:25 INFO - PROCESS | 13952 | Cycle 1(1): loaded http://localhost:33965/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33965/tests/kraken/driver.html?testName=ai-astar) 09:53:26 INFO - PROCESS | 13952 | RSS: Main: 157769728 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | __start_tp_report 09:53:26 INFO - PROCESS | 13952 | _x_x_mozilla_page_load 09:53:26 INFO - PROCESS | 13952 | _x_x_mozilla_page_load_details 09:53:26 INFO - PROCESS | 13952 | |i|pagename|runs| 09:53:26 INFO - PROCESS | 13952 | |0;ai-astar;109;111;103;108;111;109;101;110;109;109 09:53:26 INFO - PROCESS | 13952 | |1;audio-beat-detection;161;126;155;180;132;157;156;127;183;133 09:53:26 INFO - PROCESS | 13952 | |2;audio-dft;161;163;164;161;163;163;162;163;161;161 09:53:26 INFO - PROCESS | 13952 | |3;audio-fft;76;77;76;198;77;75;75;77;161;75 09:53:26 INFO - PROCESS | 13952 | |4;audio-oscillator;93;93;159;92;94;94;148;92;91;147 09:53:26 INFO - PROCESS | 13952 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 09:53:26 INFO - PROCESS | 13952 | |6;imaging-darkroom;146;145;146;146;148;147;146;147;146;146 09:53:26 INFO - PROCESS | 13952 | |7;imaging-desaturate;95;95;95;96;95;96;96;95;95;95 09:53:26 INFO - PROCESS | 13952 | |8;json-parse-financial;55;57;55;55;58;63;56;76;59;53 09:53:26 INFO - PROCESS | 13952 | |9;json-stringify-tinderbox;59;60;59;58;58;59;58;59;60;59 09:53:26 INFO - PROCESS | 13952 | |10;stanford-crypto-aes;72;79;72;74;73;73;72;76;80;74 09:53:26 INFO - PROCESS | 13952 | |11;stanford-crypto-ccm;111;114;124;113;110;116;111;122;125;126 09:53:26 INFO - PROCESS | 13952 | |12;stanford-crypto-pbkdf2;161;158;162;167;159;167;168;156;162;159 09:53:26 INFO - PROCESS | 13952 | |13;stanford-crypto-sha256-iterative;65;66;67;68;70;67;67;67;65;66 09:53:26 INFO - PROCESS | 13952 | __end_tp_report 09:53:26 INFO - PROCESS | 13952 | __start_cc_report 09:53:26 INFO - PROCESS | 13952 | _x_x_mozilla_cycle_collect,816 09:53:26 INFO - PROCESS | 13952 | __end_cc_report 09:53:26 INFO - PROCESS | 13952 | __startTimestamp1467046406033__endTimestamp 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | ------- Summary: start ------- 09:53:26 INFO - PROCESS | 13952 | Number of tests: 14 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:3.33 (3.1%) stddev-sans-first:3.52 09:53:26 INFO - PROCESS | 13952 | Values: 109.0 111.0 103.0 108.0 111.0 109.0 101.0 110.0 109.0 109.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:156.50 stddev:20.89 (13.3%) stddev-sans-first:21.84 09:53:26 INFO - PROCESS | 13952 | Values: 161.0 126.0 155.0 180.0 132.0 157.0 156.0 127.0 183.0 133.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 09:53:26 INFO - PROCESS | 13952 | Values: 161.0 163.0 164.0 161.0 163.0 163.0 162.0 163.0 161.0 161.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#3] audio-fft Cycles:10 Average:96.70 Median:76.00 stddev:44.51 (58.6%) stddev-sans-first:46.58 09:53:26 INFO - PROCESS | 13952 | Values: 76.0 77.0 76.0 198.0 77.0 75.0 75.0 77.0 161.0 75.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:28.50 (30.8%) stddev-sans-first:29.54 09:53:26 INFO - PROCESS | 13952 | Values: 93.0 93.0 159.0 92.0 94.0 94.0 148.0 92.0 91.0 147.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:53:26 INFO - PROCESS | 13952 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:53:26 INFO - PROCESS | 13952 | Values: 146.0 145.0 146.0 146.0 148.0 147.0 146.0 147.0 146.0 146.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:53:26 INFO - PROCESS | 13952 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.50 stddev:6.68 (11.6%) stddev-sans-first:6.95 09:53:26 INFO - PROCESS | 13952 | Values: 55.0 57.0 55.0 55.0 58.0 63.0 56.0 76.0 59.0 53.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 09:53:26 INFO - PROCESS | 13952 | Values: 59.0 60.0 59.0 58.0 58.0 59.0 58.0 59.0 60.0 59.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.92 (3.9%) stddev-sans-first:2.95 09:53:26 INFO - PROCESS | 13952 | Values: 72.0 79.0 72.0 74.0 73.0 73.0 72.0 76.0 80.0 74.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:119.00 stddev:6.37 (5.4%) stddev-sans-first:6.35 09:53:26 INFO - PROCESS | 13952 | Values: 111.0 114.0 124.0 113.0 110.0 116.0 111.0 122.0 125.0 126.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:4.18 (2.6%) stddev-sans-first:4.42 09:53:26 INFO - PROCESS | 13952 | Values: 161.0 158.0 162.0 167.0 159.0 167.0 168.0 156.0 162.0 159.0 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - PROCESS | 13952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.41 09:53:26 INFO - PROCESS | 13952 | Values: 65.0 66.0 67.0 68.0 70.0 67.0 67.0 67.0 65.0 66.0 09:53:26 INFO - PROCESS | 13952 | -------- Summary: end -------- 09:53:26 INFO - PROCESS | 13952 | 09:53:26 INFO - TEST-INFO | 13952: exit 0 09:53:26 INFO - TEST-OK | kraken | took 60671ms 09:53:26 INFO - SUITE-END | took 1169s 09:53:27 INFO - Completed test suite (00:19:30) 09:53:27 INFO - javascript benchmark 09:53:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.6254880688716, 3338.0, 3370.1069216657575, 3414.7438942079334, 3417.3165366926605, 5467.863303417412, 5485.314335708036, 5498.80754173604, 5503.587230957674, 5510.944890551098, 5510.614257002011, 5539.307586551681, 5549.223108764776, 5549.667019978794, 5564.165375193723, 5000.0999820032375, 5011.42368627607, 5045.243213517965, 5060.54455099041, 5065.79736810529, 5003.524665156822, 5070.974645126769, 5125.743712814363, 5178.404483484391, 5207.114790485626, 4998.800047998094, 5069.087564238435, 5071.163258062434, 5124.564412024983, 5137.280780690688, 5044.47033061527, 5049.899002019939, 5059.06407314648, 5061.468545802712, 5089.949100508985, 4921.0, 4994.675346102492, 5043.571296439807, 5049.64652474327, 5051.090803655341, 5311.5750739941095, 5380.946190538123, 5442.2380866678695, 5457.754401051922, 5463.371712253102, 5890.587658863881, 5901.439363260483, 5916.704164791743, 5918.112283157518, 5943.435373639541, 5800.216970708942, 5957.255343082114, 5957.582969192158, 5966.67183304918, 5979.0, 5548.6948217848, 5553.6390134641115, 5581.720913954286, 5584.636998595079, 5592.720363981784, 6039.396060394013, 6057.515398768088, 6073.1497590337385, 6075.574709770273, 6093.6039157454625, 5786.218860453785, 5790.131480277992, 5816.41835816415, 5837.270341207349, 5841.620294680833, 5884.558658100659, 5939.792107276225, 5942.524598032147, 5946.643201407929, 5979.760809567656, 5904.232449781501, 5908.291005079418, 5920.703964801743, 5928.79249226275, 5934.8813023739285, 5714.485696287354, 5821.476067153976, 5892.469677729025, 5909.025010873243, 5934.228550288522, 4494.9325760113625, 4525.63794896414, 4538.069695712371, 4543.295789152687, 4554.977225113853, 4077.3068578341754, 4078.9796051019557, 4113.4446849675505, 4117.114820313647, 4120.381942708557, 5597.74810133545, 5674.858128546819, 5744.454276843693, 5748.48263656273, 5756.740946657411, 5839.299284085937, 5915.763369465173, 5994.1608174855555, 5996.190514280604, 6022.638641681513, 5698.943010569924, 5699.572532060112, 5712.657240565496, 5716.628419152742, 5723.170140329629, 4957.3555437793575, 4992.625553083533, 5013.874653133701, 5030.346055012898, 5042.168042272984, 6075.574709770273, 6112.572119951649, 6132.478739307119, 6138.263408390932, 6142.293636231891, 5883.941160588511, 6005.159277701126, 6010.639361638316, 6011.128386384037, 6019.488343490677, 6083.543734220039, 6118.253719382578, 6152.538559608137, 6156.907646385218, 6174.845628859314, 5907.202527658711, 5907.202527658711, 5913.408659134052, 5914.083317085859, 5926.318473375444, 5898.4101589842385, 5960.403959604005, 6015.218021657157, 6020.0, 6023.0, 5794.855128621818, 5823.126531020381, 5832.591718579659, 5835.503982161564, 5861.9413805861395, 5758.596898217084, 5776.56675749312, 5797.362290147996, 5804.158397032491, 5821.98115329824, 5539.473749993744, 5700.3444603871085, 5733.111367738007, 5734.770609175586, 5836.037053886062, 5798.159266906359, 5826.446487583673, 5830.271216097988, 5830.300363956352, 5838.3869693683255, 5714.285714285715, 5714.714264286852, 5723.027085395576, 5745.109508026263, 5755.107958266475], "value": 5480.882818287377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.5927684112694, 682.8839097353451, 699.7550857199984, 730.6091241185967, 745.455817253405, 39663.80168099159, 40587.594124058785, 40765.7961710191, 40809.795951020205, 40871.79564102179, 43814.7809260954, 44219.33670994938, 44323.0, 44411.55588444114, 44479.33281000787, 8929.330300227477, 9088.77278068047, 9102.408343457688, 9106.362554621179, 9108.134727200939, 8844.690435834747, 8993.910060899405, 8997.190252877239, 8997.595108220146, 9014.053524379944, 9297.953510232439, 9330.346875718702, 9351.205147562465, 9354.251659867194, 9412.152906238438, 9218.953905230464, 9273.397229180115, 9281.118293762082, 9323.627054917795, 9330.253579713606, 9191.678291259841, 9281.489518076503, 9306.976232614406, 9325.720228393158, 9331.486768227745, 43458.0, 43612.0, 43734.781326093165, 43862.56137438617, 43959.0, 4169.666426685858, 4179.03882107114, 4202.6847986400835, 4349.282368409209, 4753.643476739258, 33483.0, 33853.15367115817, 34511.0, 34558.30883382344, 35046.64953350459, 4589.265717485219, 4615.95384046162, 4653.511381304982, 4692.460367057798, 4704.411948506437, 248350.0, 248353.0, 248628.75685621638, 248992.0, 251154.0, 63438.68280658659, 63597.0, 63813.0, 63815.40461488407, 63853.36146638567, 66999.66500167566, 71260.0, 72462.0, 72472.0, 72537.0, 18882.81117188838, 18989.240430382906, 19161.808381916002, 19172.041397930047, 19233.61532769365, 13567.0, 13630.522931697344, 13639.931800341134, 13645.795313070312, 13655.863441365658, 21012.894935525226, 21178.576428471344, 21276.255331063338, 21292.574148516942, 21313.147474101173, 7691.923080769233, 7770.0, 7808.7657370278985, 7840.41196910234, 8026.558539280279, 1096.857408536885, 1109.7614012987246, 1149.770045990805, 1162.3026184289358, 1191.2495128069434, 28746.712532874823, 29347.0, 29373.0, 29920.85039574832, 30079.548806767914, 1244.595506460404, 1248.8813562711528, 1331.467413034794, 1350.8108864758942, 1369.8082268482422, 15516.836237282248, 16516.42192523256, 16664.917829643393, 16729.16354182286, 16865.494035178963, 509639.0, 884922.0, 886392.0, 895749.0, 908893.0, 63564.68217658975, 64334.0, 64348.356516435175, 64512.354876450634, 64924.675376622814, 1461.7295800276984, 1531.257340190007, 1539.3226980128932, 1543.436645624339, 1550.6976139652659, 33110.5033424494, 33330.0, 33603.49594756032, 33705.83147084249, 34431.311373772885, 54890.451095490134, 55191.17213241724, 55236.0, 55631.16553251785, 55719.72140139274, 426809.0, 430011.0, 431208.0, 432597.0, 433035.0, 45531.0, 46345.30482042839, 46383.304250436944, 46446.0, 46566.0, 51062.74468627633, 51609.74195129, 52484.0, 52582.73708631432, 53717.46282537124, 39997.40003899886, 41981.580184197766, 42434.0, 42894.14211715811, 43962.78018609886, 43101.0, 44802.0, 48795.5120448791, 48952.75523622359, 49542.0, 42684.78657606692, 42856.78571607122, 43067.7846610765, 43183.568164317956, 43722.781386092865, 36900.630993689716, 37025.444618330206, 37181.62818371782, 37715.62284377121, 37733.4339984906, 29520.0, 29610.259743506584, 29661.258468537595, 29962.501874906604, 30396.696033040273], "value": 21710.9392601077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.44098513707155, 379.96960243180513, 392.23122679548084, 396.33020195868977, 396.82143035633953, 18486.630267394645, 20744.688829667568, 21290.254841080565, 21338.146474141035, 21392.144314227433, 19788.802111978875, 20381.28665496708, 20535.486612834688, 20541.897290513527, 20776.168953241853, 5782.161586569945, 5951.345352011286, 5977.073553599199, 5986.700664966756, 6003.7898673546215, 5834.124881267801, 6106.328303886569, 6112.235970503687, 6113.816585502442, 6123.050927106306, 6051.576389652704, 6052.788152414666, 6057.757689692407, 6072.0, 6457.709403076849, 6636.270010298863, 6765.0, 6766.086578311914, 6790.932090679079, 6804.48966327525, 5991.131285963511, 6040.486558642477, 6055.2430946131735, 6075.848103797396, 6080.179175811298, 22781.54436911269, 22947.770522294897, 23542.52914941709, 24125.0, 24149.758502414927, 2465.1248806673552, 2478.0459523083564, 2535.0620270500035, 2615.0716495643965, 2836.517791975369, 10025.699229023141, 10500.2649814513, 10546.156307495383, 10729.927007299286, 10855.51150198243, 2028.4827369020952, 2060.1553363121047, 2082.1046949811575, 2111.714918486, 2171.4137182960512, 81740.59129704373, 82936.58531707303, 85807.57096214542, 86045.13954860433, 87349.0, 11330.716732081764, 11502.677192123014, 11602.0, 11621.302721836717, 11725.472353744102, 16664.583385415463, 16687.249073791707, 16693.248803803857, 16719.49841504757, 16730.6653866922, 8842.867356989651, 9098.090190980849, 9133.315001374924, 9136.954315228515, 9291.0, 9084.137006984325, 9086.000539940602, 9149.268058555299, 9232.399894007003, 9235.399699019543, 5013.298138260647, 5043.84868453947, 5086.237064440364, 5120.897582048338, 5195.532402083831, 2013.9395818125479, 2082.4065141434617, 2099.559092590573, 2117.3965419855267, 2138.0223293453805, 944.3436811416, 962.8170647576937, 1001.399160503692, 1078.2775540387959, 1083.236318395545, 18625.348112816257, 18786.342478013477, 19163.904180479007, 19187.616247675247, 19283.22867085301, 1066.6959916423782, 1069.4225118435957, 1079.6976846482996, 1080.6433876820631, 1098.7804634637987, 10393.53229104692, 10932.945335273433, 10962.177836662122, 11014.371341092436, 11155.442227888572, 518373.0, 525089.0, 528154.0, 534741.0, 545126.0, 85067.0, 94790.52604736932, 97279.0, 101166.49416753017, 102334.48832755937, 1134.9943250283861, 1145.3814939932342, 1161.6863446869297, 1183.065378351093, 1202.3747651221315, 17230.310787568356, 17676.20457079409, 17703.73444398361, 17710.0, 17785.911070444567, 39693.2061358777, 40294.19411611693, 40499.797501012305, 41067.383989240785, 41203.38194927019, 58479.4152058474, 60354.0, 60596.39403605908, 61975.6901215491, 62048.37951620426, 8598.140185981352, 8672.176143266379, 8703.129687031245, 8747.343949203709, 8782.385233033627, 11593.768124637629, 12587.685307867376, 13063.281519516519, 13395.464181432633, 13707.314634268047, 6231.501479881689, 9243.676471323472, 11827.0, 11967.880321196677, 11996.520139194683, 11426.0, 11440.82838757436, 11546.59586914454, 11727.0, 11790.0, 6501.73993040292, 10057.692499975248, 10471.3193642413, 10794.136469082612, 12387.75224495487, 8758.255548278214, 8787.472751634923, 8863.911360886308, 8866.379353445196, 8941.0, 10997.890021100007, 11539.88460115388, 11755.88244117548, 11853.466594003117, 11955.282683039046], "value": 9601.21064418805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.0896875327935, 1560.6644571417144, 1824.2064701854695, 1928.7685477742673, 1959.1975382647954, 7487.25127487251, 7926.0, 8315.83368332633, 8565.0, 8567.700130495426, 8293.958530207356, 8323.084460709317, 8398.664053437855, 8404.62179201936, 8405.705800296992, 2186.4752459409788, 2213.0, 2215.523662412581, 2216.4569680428317, 2218.223621732397, 2307.0, 2384.237044145874, 2406.927792166229, 2411.1801987324307, 2413.78275955164, 2415.6497307890345, 2430.404550885036, 2440.1093600835657, 2453.374389530667, 2457.2382561405934, 2332.0671731307443, 2339.4502291961376, 2342.3090188394463, 2351.71779386473, 2393.210240620591, 2376.4771750214927, 2379.262428647125, 2405.025964484369, 2405.807535397164, 2413.5776239158076, 8535.061143274235, 8540.103289154673, 8573.485590864506, 8575.699850505265, 8602.225799678059, 5273.367195936512, 5351.678899266057, 5401.081816091274, 5401.378841433247, 5444.591655625804, 3426.2804810989724, 3428.879989200391, 3496.8776092836883, 3510.1049232445816, 3523.4362501999813, 1093.4040947683532, 1105.3257512917114, 1115.1023426141953, 1129.4409267412602, 1153.1870031627766, 12190.695232619168, 12227.449764760608, 12228.327441990687, 12236.265824050586, 12246.387680615933, 4428.512863585003, 4533.77331133442, 4596.747178905125, 4624.121416930772, 4625.537446255415, 10254.128399086012, 10260.794784104277, 10284.845727314096, 10290.176785857113, 10315.793684126425, 5209.114450543341, 5253.605979551549, 5262.421133675292, 5265.657732247391, 5271.604629652791, 4753.453352864396, 4819.987802561432, 4851.80592776285, 4887.0714564232685, 4900.387451568554, 3777.1690228149764, 3797.6202379761803, 3839.6928245740833, 3844.0774214188395, 3868.787216703052, 1068.71144790906, 1071.6356438810685, 1082.4520935062778, 1085.1264731890747, 1160.2980196980873, 956.5743244256379, 1012.4178597306578, 1048.1614708233535, 1057.1384321777728, 1064.6433444795925, 5818.069108942549, 6014.548908831855, 6066.423689749467, 6070.666113363807, 6301.306856245809, 1016.5120742043861, 1063.3035361838008, 1073.0985971783582, 1082.4533610526792, 1083.6478144603036, 4109.506859176918, 4156.43888075112, 4159.875203743832, 4162.396452514368, 4181.351890456984, 9948.502574871227, 10231.232657550714, 10308.072273495422, 10323.793524129474, 10330.070293673605, 10065.647702330383, 10130.138938190188, 10140.645077422254, 10164.796704066026, 10179.338343007681, 7781.92218077812, 8053.1141574426765, 8068.07217170033, 8172.713955011546, 8258.504489730516, 6019.548533860066, 6185.2886918003205, 6324.873502529832, 6350.396712312323, 6386.265579458422, 9415.62337506492, 9496.717943077596, 9505.28710346713, 9619.903800961902, 9663.855042174513, 9319.720408387759, 9539.856902146612, 9682.75793105178, 9874.40753554789, 9918.355306905316, 7374.188839227788, 7526.473146879666, 7556.622168891643, 7727.304542591194, 7894.6842126314305, 7934.6826126956585, 7951.562664053533, 7976.322012628992, 8012.639431225725, 8014.919850801417, 7251.601161935933, 7361.779146625609, 7390.482666213528, 7514.39884809203, 7553.584552849646, 7228.31331023552, 7263.418926485974, 7268.418526517971, 7275.490715649854, 7300.96349518249, 6749.662516874235, 6773.322667733384, 6789.796306110825, 6821.761238356634, 6852.040714300102, 5169.896602068013, 5186.611004174627, 5216.035033518811, 5269.657472264291, 5278.208268759717, 5306.310179676618, 5356.544693701079, 5410.836670115944, 5522.751476183662, 5525.889482210253], "value": 4613.158697635571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1049862614757, 337.54431517451445, 341.56279961649096, 342.761780562509, 345.88931541906567, 6309.1482649842255, 6370.394812492812, 6451.483881289498, 6464.159659244292, 6477.157969463963, 6334.049892516125, 6355.5233357498255, 6356.809295721136, 6370.394812492817, 6389.137466442029, 4641.327007583898, 4784.760761961906, 4800.087983283182, 4819.156647586676, 4827.879303017417, 4767.380240568738, 4789.712617242959, 4798.208295631217, 4808.807647694106, 4810.567048965592, 4744.240921452569, 4756.35789168463, 4756.5243475652505, 4767.356406885078, 4770.666053376265, 4760.452547956995, 4765.189917713997, 4768.73771942543, 4779.522047795227, 4789.712617242976, 4123.958760412387, 4131.380292956051, 4132.049628585412, 4142.171565686845, 4150.190712811003, 5959.0, 6092.634441933498, 6153.384661533811, 6160.414760597736, 6162.0, 5542.667439953616, 5572.58205634579, 5574.777008919638, 5586.301712285965, 5589.0, 6800.761973330909, 6832.59004459734, 6839.658017099126, 6841.2132604750595, 6858.759943401957, 4544.909101817978, 4569.817207311704, 4575.4051973243595, 4577.656675749332, 4585.174668559658, 7043.718251269943, 7112.004319395289, 7113.288671132897, 7114.822129446805, 7125.038119853805, 4509.2559727644575, 4641.234196357631, 4673.088747694167, 4675.555822196886, 4678.064387122521, 4696.718196908197, 4708.81164753406, 4719.83480578185, 4728.40894888139, 4748.430188377417, 5514.338279406497, 5525.557955363642, 5527.861803454945, 5531.723413829292, 5554.91667624986, 6818.147731533559, 6826.180858297036, 6828.52200345981, 6839.879637312449, 6857.314268573203, 1645.9670806583802, 1665.900045997244, 1670.6491636756175, 1671.456776547627, 1673.564873132994, 1013.7646489490655, 1056.9682909512726, 1064.6593090211213, 1066.0831684751108, 1066.9786604267872, 6572.11276477679, 6602.108715323466, 6606.504512161607, 6622.966885165543, 6637.137172167587, 7046.894296585555, 7056.223815380304, 7061.258567850405, 7067.081279433641, 7067.081279433641, 6510.446612037935, 6627.834304142339, 6659.167604049494, 6660.933390666129, 6712.798616041527, 3798.1264309209037, 3829.525632631401, 3833.290841194388, 3834.175652234783, 3853.2100919311474, 7229.0, 7286.089238845145, 7305.926940730631, 7314.561126332437, 7325.816854578678, 7174.533655312493, 7174.892376614355, 7180.964095179491, 7201.89197162043, 7245.492815502864, 7137.92862071383, 7349.669264883093, 7365.447591430664, 7367.81580460482, 7368.778936631802, 7099.432045436456, 7129.0, 7133.0, 7135.82160445993, 7140.107486564179, 7006.404455621126, 7016.719331226694, 7024.192217895007, 7024.227334993045, 7034.718611255493, 7201.2438693938475, 7334.413246940126, 7351.338379545867, 7353.7058517660835, 7360.631968401452, 4619.838305659286, 4660.347551342747, 4666.0434610904, 4670.346151538719, 4677.438707355003, 7057.364837164474, 7085.539439936388, 7085.9645701773225, 7112.57324560528, 7116.718990581745, 6815.522913396213, 6847.794566163023, 6857.27998560164, 6864.7940561783225, 6874.896876546756, 6827.48793840454, 6841.21326047491, 6851.45188384938, 6855.897161542481, 6864.5881247125335, 6473.676316184266, 6609.504287178577, 6714.798556043326, 6746.797596072126, 6750.5274630775375, 6882.623475304859, 6897.517173797786, 6905.75829845953, 6905.792826215222, 6912.101426814482, 6723.966380168068, 6752.08846805675, 6755.324467553205, 6757.729690812509, 6759.628220447923], "value": 5083.221639402022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.8936343593613, 812.8536863364595, 878.8925953298842, 894.9320148331271, 908.1826356279348, 15459.45891893784, 15701.842981570195, 15777.921110394433, 15866.920665396672, 15875.68248635028, 13376.799348009788, 13449.798253026212, 13601.52394666187, 13865.237411942364, 13950.372233249504, 909.9545022748853, 917.3486824354716, 940.1679513630418, 941.1200527506769, 941.1341565759518, 933.0855761353878, 933.3932943586655, 934.5747684803398, 934.8784657994452, 936.9390989585689, 980.2452111873853, 983.9754006149868, 984.4044353166339, 985.9852102218473, 986.6793292180071, 970.0929630795193, 972.7811242470458, 974.5663179884954, 976.4043933200742, 976.9804603907918, 721.4120491799167, 723.8443734597034, 728.1044315491922, 729.9671514781794, 731.5610633619785, 15353.616159595987, 15443.382264709398, 15471.922640386838, 15509.22453877313, 15626.453074142464, 14561.635959101, 14713.190774507399, 14715.55853324402, 14748.778768318483, 14777.926110369486, 12116.878831211663, 12328.1986670867, 12352.07359448045, 12411.193272437262, 12547.24716517012, 3997.5402828674783, 4020.3165461871554, 4068.328725760246, 4169.770662613555, 4186.832526698959, 57659.0, 58117.99999999958, 58464.41535584632, 60795.39204607942, 61931.0, 10425.9478702606, 10530.15758739299, 10537.15702743794, 10568.947155264175, 10674.519646615921, 19736.90131549333, 19771.209151633775, 19957.700634490495, 20084.196632134845, 20089.296874609317, 8515.403921725543, 8550.0, 8643.870341944876, 8679.783005424788, 8912.37613367071, 4601.171789077931, 4643.257078867365, 4754.07295577366, 4933.703977761345, 5068.56917162038, 3537.4693795930816, 3572.1962558424148, 3580.373434648926, 3585.354636165463, 3593.9281214376088, 658.96375699337, 660.8083655739878, 668.2181847238743, 679.755288096285, 680.4488364424832, 810.5136917849361, 828.0973738624928, 829.4152622401193, 841.1252297610539, 845.7335939179139, 8760.976194519528, 9135.680251191176, 9144.131307525775, 9159.725208243763, 9201.07989201088, 640.4396153365805, 651.6611362091686, 665.8102440804347, 731.9011933389031, 736.3078706016328, 4591.265397536378, 4672.883177920579, 4718.646101542329, 4745.810167593327, 4786.8085276588545, 58512.707436462544, 58580.41419585835, 61466.0, 72271.0, 72394.0, 57418.0, 57651.711741441024, 57882.131768023515, 59163.40836591665, 59539.40460595339, 50528.242076368886, 51435.7428212864, 51896.0, 53919.0, 54691.179632305546, 10296.279260451996, 10335.638252661121, 10434.739131521772, 10549.525271362654, 10563.20775941792, 39735.602643974344, 40410.59589404186, 40723.0, 41222.58777412187, 41737.791311044464, 47028.0, 47826.0, 55085.724571376886, 55147.44852551423, 56182.71908640431, 12713.682157946125, 12889.162204456681, 12970.35148242603, 13076.346182691017, 13162.934185329012, 14732.926335368255, 14885.106893585986, 15031.398744050115, 15095.849041509444, 15418.691626167189, 13238.0, 13547.729045418839, 13765.587032389045, 13955.302234888011, 14151.929240353733, 13391.397387117408, 13514.864851351755, 13732.382042808298, 13780.517681881087, 13806.240656763974, 13423.127496712683, 13561.796573051215, 13618.727625447635, 14026.0, 14340.784888226477, 11211.383373914186, 11366.204365694322, 11435.485403156712, 11625.709357266136, 11995.280283183038, 11692.88307116952, 11833.82249266279, 11914.16600837933, 12132.818007730068, 12189.451474683483], "value": 7298.309345223302, "unit": "score"}], "name": "dromaeo_css", "value": 7618.615570481229, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 103.0, 108.0, 111.0, 109.0, 101.0, 110.0, 109.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 155.0, 180.0, 132.0, 157.0, 156.0, 127.0, 183.0, 133.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 161.0, 163.0, 163.0, 162.0, 163.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 198.0, 77.0, 75.0, 75.0, 77.0, 161.0, 75.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 159.0, 92.0, 94.0, 94.0, 148.0, 92.0, 91.0, 147.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 55.0, 55.0, 58.0, 63.0, 56.0, 76.0, 59.0, 53.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 58.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 72.0, 74.0, 73.0, 73.0, 72.0, 76.0, 80.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 124.0, 113.0, 110.0, 116.0, 111.0, 122.0, 125.0, 126.0], "value": 117.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 162.0, 167.0, 159.0, 167.0, 168.0, 156.0, 162.0, 159.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 68.0, 70.0, 67.0, 67.0, 67.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1524.9, "alertThreshold": 2.0}]} 09:53:27 INFO - Return code: 0 09:53:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:53:27 ERROR - # TBPL SUCCESS # 09:53:27 INFO - Running post-action listener: _resource_record_post_action 09:53:27 INFO - Running post-run listener: _resource_record_post_run 09:53:28 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 470552576; Read time: 0; Write time: 802312 09:53:28 INFO - install - Wall time: 14s; CPU: 18.0%; Read bytes: 0; Write bytes: 250871808; Read time: 0; Write time: 568416 09:53:28 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 219680768; Read time: 0; Write time: 233896 09:53:28 INFO - Running post-run listener: _upload_blobber_files 09:53:28 INFO - Blob upload gear active. 09:53:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:28 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 09:53:28 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:28 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:29 INFO - (blobuploader) - INFO - Done attempting. 09:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:30 INFO - (blobuploader) - INFO - Done attempting. 09:53:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:30 INFO - Return code: 0 09:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/003297a3e74e65505e6d8bee03307427f4625207a2805a73fa669a8c75d700a8cdd6ee441c1a23dd7ad04cefbed9f5edbb27edaa4d3eb0e48a3350dbc28df11c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a5fdc6809a63751a212301df57cddfb02817dd80910201209832ebf729aa3abcba5539c8edda03a7c76eed0c4e6399d7e49aea067284ad334fb8b38acc8c57"} 09:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:30 INFO - Contents: 09:53:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/003297a3e74e65505e6d8bee03307427f4625207a2805a73fa669a8c75d700a8cdd6ee441c1a23dd7ad04cefbed9f5edbb27edaa4d3eb0e48a3350dbc28df11c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a5fdc6809a63751a212301df57cddfb02817dd80910201209832ebf729aa3abcba5539c8edda03a7c76eed0c4e6399d7e49aea067284ad334fb8b38acc8c57"} 09:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:30 INFO - Copying logs to upload dir... 09:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.744718 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-27 09:53:30.256736) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:53:30.259832) ========= 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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/003297a3e74e65505e6d8bee03307427f4625207a2805a73fa669a8c75d700a8cdd6ee441c1a23dd7ad04cefbed9f5edbb27edaa4d3eb0e48a3350dbc28df11c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a5fdc6809a63751a212301df57cddfb02817dd80910201209832ebf729aa3abcba5539c8edda03a7c76eed0c4e6399d7e49aea067284ad334fb8b38acc8c57"} build_url:https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/YbnW1ebERAqf_5VT-ct8Xg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/003297a3e74e65505e6d8bee03307427f4625207a2805a73fa669a8c75d700a8cdd6ee441c1a23dd7ad04cefbed9f5edbb27edaa4d3eb0e48a3350dbc28df11c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a5fdc6809a63751a212301df57cddfb02817dd80910201209832ebf729aa3abcba5539c8edda03a7c76eed0c4e6399d7e49aea067284ad334fb8b38acc8c57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:53:30.286574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:53:30.286918) ========= 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=8783db0840cc980e80bb0bd400000236-1467044804.459683-1890625642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:53:30.370771) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:53:30.371135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:53:30.371474) ========= ========= Total master_lag: 0.21 =========