builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1467081367.87 results: success (0) buildid: 20160627163033 builduid: 657e5cffe6a14dbb9abb02fcbdc017ce revision: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:07.865773) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:07.866288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:07.866567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:07.881633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:07.881974) ========= 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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 19:36:08-- 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% 46.8M=0s 2016-06-27 19:36:08 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:08.113079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:08.113414) ========= 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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:08.163239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 19:36:08.163599) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 --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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 19:36:08,401 truncating revision to first 12 chars 2016-06-27 19:36:08,402 Setting DEBUG logging. 2016-06-27 19:36:08,402 attempt 1/10 2016-06-27 19:36:08,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7bcb335a9bc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 19:36:09,115 unpacking tar archive at: mozilla-inbound-7bcb335a9bc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 19:36:09.214095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:09.214416) ========= script_repo_revision: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:09.214830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:09.215095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 19:36:09.226898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 19:36:09.227215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:36:09 INFO - MultiFileLogger online at 20160627 19:36:09 in /builds/slave/test 19:36:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:36:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:09 INFO - {'append_to_log': False, 19:36:09 INFO - 'base_work_dir': '/builds/slave/test', 19:36:09 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:36:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:09 INFO - 'branch': 'Mozilla-Inbound', 19:36:09 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:09 INFO - 'config_files': ('talos/linux_config.py',), 19:36:09 INFO - 'default_actions': ('clobber', 19:36:09 INFO - 'read-buildbot-config', 19:36:09 INFO - 'download-and-extract', 19:36:09 INFO - 'populate-webroot', 19:36:09 INFO - 'create-virtualenv', 19:36:09 INFO - 'install', 19:36:09 INFO - 'run-tests'), 19:36:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:09 INFO - 'download_minidump_stackwalk': True, 19:36:09 INFO - 'download_symbols': 'ondemand', 19:36:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:09 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:09 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:09 INFO - 'installer_path': 'installer.exe', 19:36:09 INFO - 'log_level': 'info', 19:36:09 INFO - 'log_name': 'talos', 19:36:09 INFO - 'log_to_console': True, 19:36:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:36:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:36:09 INFO - 'opt_config_files': (), 19:36:09 INFO - 'pip_index': False, 19:36:09 INFO - 'sps_profile': False, 19:36:09 INFO - 'sps_profile_interval': 0, 19:36:09 INFO - 'suite': 'dromaeojs-e10s', 19:36:09 INFO - 'system_bits': '32', 19:36:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:09 INFO - 'title': 'talos-linux64-ix-010', 19:36:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:09 INFO - 'use_talos_json': True, 19:36:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:09 INFO - 'work_dir': 'build'} 19:36:09 INFO - ##### 19:36:09 INFO - ##### Running clobber step. 19:36:09 INFO - ##### 19:36:09 INFO - Running pre-action listener: _resource_record_pre_action 19:36:09 INFO - Running main action method: clobber 19:36:09 INFO - rmtree: /builds/slave/test/build 19:36:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:10 INFO - Running post-action listener: _resource_record_post_action 19:36:10 INFO - ##### 19:36:10 INFO - ##### Finished clobber step (success) 19:36:10 INFO - ##### 19:36:10 INFO - ##### 19:36:10 INFO - ##### Running read-buildbot-config step. 19:36:10 INFO - ##### 19:36:10 INFO - Running pre-action listener: _resource_record_pre_action 19:36:10 INFO - Running main action method: read_buildbot_config 19:36:10 INFO - Using buildbot properties: 19:36:10 INFO - { 19:36:10 INFO - "project": "", 19:36:10 INFO - "product": "firefox", 19:36:10 INFO - "script_repo_revision": "production", 19:36:10 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:36:10 INFO - "repository": "", 19:36:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:36:10 INFO - "buildid": "20160627163033", 19:36:10 INFO - "pgo_build": "True", 19:36:10 INFO - "basedir": "/builds/slave/test", 19:36:10 INFO - "buildnumber": 918, 19:36:10 INFO - "slavename": "talos-linux64-ix-010", 19:36:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:36:10 INFO - "platform": "ubuntu64_hw", 19:36:10 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:36:10 INFO - "branch": "mozilla-inbound", 19:36:10 INFO - "repo_path": "integration/mozilla-inbound", 19:36:10 INFO - "revision": "7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95", 19:36:10 INFO - "stage_platform": "linux64-pgo", 19:36:10 INFO - "builduid": "657e5cffe6a14dbb9abb02fcbdc017ce", 19:36:10 INFO - "slavebuilddir": "test" 19:36:10 INFO - } 19:36:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:36:10 INFO - Running post-action listener: _resource_record_post_action 19:36:10 INFO - ##### 19:36:10 INFO - ##### Finished read-buildbot-config step (success) 19:36:10 INFO - ##### 19:36:10 INFO - ##### 19:36:10 INFO - ##### Running download-and-extract step. 19:36:10 INFO - ##### 19:36:10 INFO - Running pre-action listener: _resource_record_pre_action 19:36:10 INFO - Running main action method: download_and_extract 19:36:10 INFO - mkdir: /builds/slave/test/build/tests 19:36: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')]} 19:36:10 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:36:10 INFO - Downloaded 1361 bytes. 19:36:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:36:10 INFO - Using the following test package requirements: 19:36:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:36:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:36:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'jsshell-linux-x86_64.zip'], 19:36:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:36:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:36:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:36:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:36:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:36:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:36: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')]} 19:36:10 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:11 INFO - Downloaded 24282861 bytes. 19:36:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:36:13 INFO - Return code: 0 19:36:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:13 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')]} 19:36:13 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:36:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:14 INFO - Downloaded 24282861 bytes. 19:36:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:36:15 INFO - Return code: 0 19:36:15 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')]} 19:36:15 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:36:16 INFO - Downloaded 14405240 bytes. 19:36:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:36:16 INFO - Return code: 0 19:36:16 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')]} 19:36:16 INFO - https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:36:18 INFO - Downloaded 60322333 bytes. 19:36:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:36:18 INFO - mkdir: /builds/slave/test/properties 19:36:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:18 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:18 INFO - Contents: 19:36:18 INFO - build_url:https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:36:19 INFO - Running post-action listener: _resource_record_post_action 19:36:19 INFO - Running post-action listener: set_extra_try_arguments 19:36:19 INFO - ##### 19:36:19 INFO - ##### Finished download-and-extract step (success) 19:36:19 INFO - ##### 19:36:19 INFO - ##### 19:36:19 INFO - ##### Running populate-webroot step. 19:36:19 INFO - ##### 19:36:19 INFO - Running pre-action listener: _resource_record_pre_action 19:36:19 INFO - Running main action method: populate_webroot 19:36:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:19 INFO - '--tppagecycles', 19:36:19 INFO - '7'], 19:36:19 INFO - 'tests': ['tsvgm']}}, 19:36:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:36:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:36:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['damp', 'tps']}, 19:36:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'tests': ['damp', 'tps']}, 19:36:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['dromaeo_dom']}, 19:36:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['basic_compositor_video']}, 19:36:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:36:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'other-e10s': {'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['a11yr', 19:36:19 INFO - 'ts_paint', 19:36:19 INFO - 'tpaint', 19:36:19 INFO - 'sessionrestore', 19:36:19 INFO - 'sessionrestore_no_auto_restore', 19:36:19 INFO - 'tabpaint']}, 19:36:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['tsvgx', 19:36:19 INFO - 'tsvgr_opacity', 19:36:19 INFO - 'tart', 19:36:19 INFO - 'tscrollx', 19:36:19 INFO - 'cart']}, 19:36:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:36:19 INFO - 'tsvgr_opacity', 19:36:19 INFO - 'tart', 19:36:19 INFO - 'tscrollx', 19:36:19 INFO - 'cart']}, 19:36:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'talos_options': ['--disable-e10s'], 19:36:19 INFO - 'tests': ['tp5o']}, 19:36:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'tests': ['tp5o']}, 19:36:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'talos_options': ['--disable-e10s', 19:36:19 INFO - '--xperf_path', 19:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:19 INFO - 'tests': ['tp5n']}, 19:36:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:19 INFO - 'talos_options': ['--xperf_path', 19:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:19 INFO - 'tests': ['tp5n']}}, 19:36:19 INFO - 'talos.zip': {'path': '', 19:36:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:19 INFO - Running post-action listener: _resource_record_post_action 19:36:19 INFO - ##### 19:36:19 INFO - ##### Finished populate-webroot step (success) 19:36:19 INFO - ##### 19:36:19 INFO - ##### 19:36:19 INFO - ##### Running create-virtualenv step. 19:36:19 INFO - ##### 19:36:19 INFO - Running pre-action listener: _resource_record_pre_action 19:36:19 INFO - Running main action method: create_virtualenv 19:36:19 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:19 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 19:36:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:19 INFO - Using real prefix '/usr' 19:36:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:19 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:21 INFO - Installing pip.................done. 19:36:21 INFO - Return code: 0 19:36:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:21 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')]} 19:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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')]} 19:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:21 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 19:36:21 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 19:36:21 INFO - Using env: {'DISPLAY': ':0', 19:36:21 INFO - 'HOME': '/home/cltbld', 19:36:21 INFO - 'LANG': 'en_US.UTF-8', 19:36:21 INFO - 'LANGUAGE': 'en_US:en', 19:36:21 INFO - 'LOGNAME': 'cltbld', 19:36:21 INFO - 'MAIL': '/var/mail/cltbld', 19:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:21 INFO - 'MOZ_NO_REMOTE': '1', 19:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:21 INFO - 'NO_EM_RESTART': '1', 19:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:21 INFO - 'PWD': '/builds/slave/test', 19:36:21 INFO - 'SHELL': '/bin/bash', 19:36:21 INFO - 'SHLVL': '1', 19:36:21 INFO - 'TERM': 'linux', 19:36:21 INFO - 'TMOUT': '86400', 19:36:21 INFO - 'USER': 'cltbld', 19:36:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:21 INFO - '_': '/tools/buildbot/bin/python'} 19:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:21 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 19:36:21 INFO - Cleaning up... 19:36:21 INFO - Return code: 0 19:36:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:36:21 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')]} 19:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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')]} 19:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:21 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:21 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>=3.1.1'] in /builds/slave/test/build 19:36:21 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>=3.1.1 19:36:21 INFO - Using env: {'DISPLAY': ':0', 19:36:21 INFO - 'HOME': '/home/cltbld', 19:36:21 INFO - 'LANG': 'en_US.UTF-8', 19:36:21 INFO - 'LANGUAGE': 'en_US:en', 19:36:21 INFO - 'LOGNAME': 'cltbld', 19:36:21 INFO - 'MAIL': '/var/mail/cltbld', 19:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:21 INFO - 'MOZ_NO_REMOTE': '1', 19:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:21 INFO - 'NO_EM_RESTART': '1', 19:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:21 INFO - 'PWD': '/builds/slave/test', 19:36:21 INFO - 'SHELL': '/bin/bash', 19:36:21 INFO - 'SHLVL': '1', 19:36:21 INFO - 'TERM': 'linux', 19:36:21 INFO - 'TMOUT': '86400', 19:36:21 INFO - 'USER': 'cltbld', 19:36:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:21 INFO - '_': '/tools/buildbot/bin/python'} 19:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:22 INFO - Downloading/unpacking psutil>=3.1.1 19:36:22 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 19:36:22 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 19:36:22 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 19:36:22 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 19:36:22 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 19:36:22 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 19:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:24 INFO - Installing collected packages: psutil 19:36:24 INFO - Running setup.py install for psutil 19:36:24 INFO - building 'psutil._psutil_linux' extension 19:36:24 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 19:36:24 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 19:36:24 INFO - building 'psutil._psutil_posix' extension 19:36:24 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 19:36:24 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 19:36:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:24 INFO - Successfully installed psutil 19:36:24 INFO - Cleaning up... 19:36:24 INFO - Return code: 0 19:36:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:36:24 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')]} 19:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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')]} 19:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:24 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.3'] in /builds/slave/test/build 19:36:24 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.3 19:36:24 INFO - Using env: {'DISPLAY': ':0', 19:36:24 INFO - 'HOME': '/home/cltbld', 19:36:24 INFO - 'LANG': 'en_US.UTF-8', 19:36:24 INFO - 'LANGUAGE': 'en_US:en', 19:36:24 INFO - 'LOGNAME': 'cltbld', 19:36:24 INFO - 'MAIL': '/var/mail/cltbld', 19:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:24 INFO - 'MOZ_NO_REMOTE': '1', 19:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:24 INFO - 'NO_EM_RESTART': '1', 19:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:24 INFO - 'PWD': '/builds/slave/test', 19:36:24 INFO - 'SHELL': '/bin/bash', 19:36:24 INFO - 'SHLVL': '1', 19:36:24 INFO - 'TERM': 'linux', 19:36:24 INFO - 'TMOUT': '86400', 19:36:24 INFO - 'USER': 'cltbld', 19:36:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:24 INFO - '_': '/tools/buildbot/bin/python'} 19:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:36:24 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 19:36:24 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 19:36:24 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 19:36:24 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 19:36:24 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 19:36:24 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 19:36:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:36:26 INFO - Installing collected packages: mozsystemmonitor 19:36:26 INFO - Running setup.py install for mozsystemmonitor 19:36:26 INFO - Successfully installed mozsystemmonitor 19:36:26 INFO - Cleaning up... 19:36:26 INFO - Return code: 0 19:36:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:36:26 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')]} 19:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 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')]} 19:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:26 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:26 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==2.5.1'] in /builds/slave/test/build 19:36:26 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==2.5.1 19:36:26 INFO - Using env: {'DISPLAY': ':0', 19:36:26 INFO - 'HOME': '/home/cltbld', 19:36:26 INFO - 'LANG': 'en_US.UTF-8', 19:36:26 INFO - 'LANGUAGE': 'en_US:en', 19:36:26 INFO - 'LOGNAME': 'cltbld', 19:36:26 INFO - 'MAIL': '/var/mail/cltbld', 19:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:26 INFO - 'MOZ_NO_REMOTE': '1', 19:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:26 INFO - 'NO_EM_RESTART': '1', 19:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:26 INFO - 'PWD': '/builds/slave/test', 19:36:26 INFO - 'SHELL': '/bin/bash', 19:36:26 INFO - 'SHLVL': '1', 19:36:26 INFO - 'TERM': 'linux', 19:36:26 INFO - 'TMOUT': '86400', 19:36:26 INFO - 'USER': 'cltbld', 19:36:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:26 INFO - '_': '/tools/buildbot/bin/python'} 19:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:27 INFO - Downloading/unpacking jsonschema==2.5.1 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:29 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:29 INFO - warning: no files found matching '*.txt' 19:36:29 INFO - no previously-included directories found matching 'build' 19:36:29 INFO - no previously-included directories found matching 'dist' 19:36:29 INFO - no previously-included directories found matching '.git*' 19:36:29 INFO - Installing collected packages: jsonschema, functools32 19:36:29 INFO - Running setup.py install for functools32 19:36:29 INFO - warning: no files found matching '*.txt' 19:36:29 INFO - no previously-included directories found matching 'build' 19:36:29 INFO - no previously-included directories found matching 'dist' 19:36:29 INFO - no previously-included directories found matching '.git*' 19:36:29 INFO - Successfully installed jsonschema functools32 19:36:29 INFO - Cleaning up... 19:36:29 INFO - Return code: 0 19:36:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:29 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:29 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 19:36:29 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 19:36:29 INFO - Using env: {'DISPLAY': ':0', 19:36:29 INFO - 'HOME': '/home/cltbld', 19:36:29 INFO - 'LANG': 'en_US.UTF-8', 19:36:29 INFO - 'LANGUAGE': 'en_US:en', 19:36:29 INFO - 'LOGNAME': 'cltbld', 19:36:29 INFO - 'MAIL': '/var/mail/cltbld', 19:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:29 INFO - 'MOZ_NO_REMOTE': '1', 19:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:29 INFO - 'NO_EM_RESTART': '1', 19:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:29 INFO - 'PWD': '/builds/slave/test', 19:36:29 INFO - 'SHELL': '/bin/bash', 19:36:29 INFO - 'SHLVL': '1', 19:36:29 INFO - 'TERM': 'linux', 19:36:29 INFO - 'TMOUT': '86400', 19:36:29 INFO - 'USER': 'cltbld', 19:36:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:29 INFO - '_': '/tools/buildbot/bin/python'} 19:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:29 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 19:36:29 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 19:36:29 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 19:36:29 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 19:36:29 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 19:36:29 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 19:36:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 INFO - Downloading docopt-0.6.1.tar.gz 19:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:32 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:32 INFO - Running setup.py install for blobuploader 19:36:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:32 INFO - Running setup.py install for requests 19:36:32 INFO - Running setup.py install for docopt 19:36:32 INFO - Successfully installed blobuploader requests docopt 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:32 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 19:36:32 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 19:36:32 INFO - Using env: {'DISPLAY': ':0', 19:36:32 INFO - 'HOME': '/home/cltbld', 19:36:32 INFO - 'LANG': 'en_US.UTF-8', 19:36:32 INFO - 'LANGUAGE': 'en_US:en', 19:36:32 INFO - 'LOGNAME': 'cltbld', 19:36:32 INFO - 'MAIL': '/var/mail/cltbld', 19:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:32 INFO - 'MOZ_NO_REMOTE': '1', 19:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:32 INFO - 'NO_EM_RESTART': '1', 19:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:32 INFO - 'PWD': '/builds/slave/test', 19:36:32 INFO - 'SHELL': '/bin/bash', 19:36:32 INFO - 'SHLVL': '1', 19:36:32 INFO - 'TERM': 'linux', 19:36:32 INFO - 'TMOUT': '86400', 19:36:32 INFO - 'USER': 'cltbld', 19:36:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - '_': '/tools/buildbot/bin/python'} 19:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:33 INFO - Running setup.py (path:/tmp/pip-US41Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:33 INFO - Running setup.py (path:/tmp/pip-IF02Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:33 INFO - Running setup.py (path:/tmp/pip-EASfgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:33 INFO - Running setup.py (path:/tmp/pip-ZkOgCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:33 INFO - Running setup.py (path:/tmp/pip-FvMslO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:33 INFO - Running setup.py (path:/tmp/pip-xk2OYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:33 INFO - Running setup.py (path:/tmp/pip-Pun1UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:33 INFO - Running setup.py (path:/tmp/pip-KxP1Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:33 INFO - Running setup.py (path:/tmp/pip-lYdZPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:33 INFO - Running setup.py (path:/tmp/pip-Q4Ukl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:33 INFO - Running setup.py (path:/tmp/pip-P2oYet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:33 INFO - Running setup.py (path:/tmp/pip-1YVDEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:34 INFO - Running setup.py (path:/tmp/pip-nM6SWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:34 INFO - Running setup.py (path:/tmp/pip-ZiAuhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:34 INFO - Running setup.py (path:/tmp/pip-DgiduI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:34 INFO - Running setup.py (path:/tmp/pip-FIWv8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:34 INFO - Running setup.py (path:/tmp/pip-SYx5GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:34 INFO - Running setup.py install for manifestparser 19:36:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozcrash 19:36:34 INFO - Running setup.py install for mozdebug 19:36:34 INFO - Running setup.py install for mozdevice 19:36:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozfile 19:36:34 INFO - Running setup.py install for mozhttpd 19:36:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozinfo 19:36:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozInstall 19:36:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozleak 19:36:35 INFO - Running setup.py install for mozlog 19:36:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for moznetwork 19:36:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozprocess 19:36:35 INFO - Running setup.py install for mozprofile 19:36:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozrunner 19:36:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:35 INFO - Running setup.py install for mozscreenshot 19:36:35 INFO - Running setup.py install for moztest 19:36:36 INFO - Running setup.py install for mozversion 19:36:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:36 INFO - Cleaning up... 19:36:36 INFO - Return code: 0 19:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:36 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:36 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 19:36:36 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 19:36:36 INFO - Using env: {'DISPLAY': ':0', 19:36:36 INFO - 'HOME': '/home/cltbld', 19:36:36 INFO - 'LANG': 'en_US.UTF-8', 19:36:36 INFO - 'LANGUAGE': 'en_US:en', 19:36:36 INFO - 'LOGNAME': 'cltbld', 19:36:36 INFO - 'MAIL': '/var/mail/cltbld', 19:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:36 INFO - 'MOZ_NO_REMOTE': '1', 19:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:36 INFO - 'NO_EM_RESTART': '1', 19:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:36 INFO - 'PWD': '/builds/slave/test', 19:36:36 INFO - 'SHELL': '/bin/bash', 19:36:36 INFO - 'SHLVL': '1', 19:36:36 INFO - 'TERM': 'linux', 19:36:36 INFO - 'TMOUT': '86400', 19:36:36 INFO - 'USER': 'cltbld', 19:36:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:36 INFO - '_': '/tools/buildbot/bin/python'} 19:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:36 INFO - Running setup.py (path:/tmp/pip-0GFe2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:36 INFO - Running setup.py (path:/tmp/pip-y2nl_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:36 INFO - Running setup.py (path:/tmp/pip-2DSpfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:36 INFO - Running setup.py (path:/tmp/pip-h6y1Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:36 INFO - Running setup.py (path:/tmp/pip-0tBOy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:36 INFO - Running setup.py (path:/tmp/pip-oJ2CwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:36 INFO - Running setup.py (path:/tmp/pip-8hC9Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:36 INFO - Running setup.py (path:/tmp/pip-EmFKsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:36 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)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:37 INFO - Running setup.py (path:/tmp/pip-0EiNfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:37 INFO - Running setup.py (path:/tmp/pip-l_oLQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:37 INFO - Running setup.py (path:/tmp/pip-NE1vMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:37 INFO - Running setup.py (path:/tmp/pip-8G4Zzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:37 INFO - Running setup.py (path:/tmp/pip-qWe7I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:37 INFO - Running setup.py (path:/tmp/pip-Su32nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:37 INFO - Running setup.py (path:/tmp/pip-tUTMyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:37 INFO - Running setup.py (path:/tmp/pip-V9_01S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:37 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)) 19:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:37 INFO - Running setup.py (path:/tmp/pip-is5MgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:37 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)) 19:36:37 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)) 19:36:37 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)) 19:36:37 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)) 19:36:37 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)) 19:36:37 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)) 19:36:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:37 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 19:36:39 INFO - Downloading blessings-1.6.tar.gz 19:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:39 INFO - Installing collected packages: blessings 19:36:39 INFO - Running setup.py install for blessings 19:36:39 INFO - Successfully installed blessings 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:40 INFO - Reading from file tmpfile_stdout 19:36:40 INFO - Current package versions: 19:36:40 INFO - argparse == 1.2.1 19:36:40 INFO - blessings == 1.6 19:36:40 INFO - blobuploader == 1.2.4 19:36:40 INFO - docopt == 0.6.1 19:36:40 INFO - functools32 == 3.2.3-2 19:36:40 INFO - jsonschema == 2.5.1 19:36:40 INFO - manifestparser == 1.1 19:36:40 INFO - mozInstall == 1.12 19:36:40 INFO - mozcrash == 0.17 19:36:40 INFO - mozdebug == 0.1 19:36:40 INFO - mozdevice == 0.48 19:36:40 INFO - mozfile == 1.2 19:36:40 INFO - mozhttpd == 0.7 19:36:40 INFO - mozinfo == 0.9 19:36:40 INFO - mozleak == 0.1 19:36:40 INFO - mozlog == 3.2 19:36:40 INFO - moznetwork == 0.27 19:36:40 INFO - mozprocess == 0.22 19:36:40 INFO - mozprofile == 0.28 19:36:40 INFO - mozrunner == 6.11 19:36:40 INFO - mozscreenshot == 0.1 19:36:40 INFO - mozsystemmonitor == 0.3 19:36:40 INFO - moztest == 0.7 19:36:40 INFO - mozversion == 1.4 19:36:40 INFO - psutil == 3.1.1 19:36:40 INFO - requests == 1.2.3 19:36:40 INFO - wsgiref == 0.1.2 19:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:40 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 19:36:40 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 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 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)) 19:36:40 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:40 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 19:36:40 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 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:36:40 INFO - Cleaning up... 19:36:40 INFO - Return code: 0 19:36:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:40 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 0x7fa6bbbf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, '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': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', '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 19:36:40 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 19:36:40 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 19:36:40 INFO - Using env: {'DISPLAY': ':0', 19:36:40 INFO - 'HOME': '/home/cltbld', 19:36:40 INFO - 'LANG': 'en_US.UTF-8', 19:36:40 INFO - 'LANGUAGE': 'en_US:en', 19:36:40 INFO - 'LOGNAME': 'cltbld', 19:36:40 INFO - 'MAIL': '/var/mail/cltbld', 19:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:40 INFO - 'MOZ_NO_REMOTE': '1', 19:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:40 INFO - 'NO_EM_RESTART': '1', 19:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:40 INFO - 'PWD': '/builds/slave/test', 19:36:40 INFO - 'SHELL': '/bin/bash', 19:36:40 INFO - 'SHLVL': '1', 19:36:40 INFO - 'TERM': 'linux', 19:36:40 INFO - 'TMOUT': '86400', 19:36:40 INFO - 'USER': 'cltbld', 19:36:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:40 INFO - '_': '/tools/buildbot/bin/python'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 INFO - Downloading/unpacking flake8 19:36:40 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 19:36:40 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 19:36:40 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 19:36:40 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 19:36:40 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 19:36:40 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 19:36:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:42 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 19:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:43 INFO - no previously-included directories found matching 'docs/_build' 19:36:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:43 INFO - Running setup.py install for pep8 19:36:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:43 INFO - no previously-included directories found matching 'docs/_build' 19:36:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:43 INFO - Cleaning up... 19:36:43 INFO - Return code: 0 19:36:43 INFO - Running post-action listener: _resource_record_post_action 19:36:43 INFO - Running post-action listener: _start_resource_monitoring 19:36:43 INFO - Starting resource monitoring. 19:36:43 INFO - ##### 19:36:43 INFO - ##### Finished create-virtualenv step (success) 19:36:43 INFO - ##### 19:36:43 INFO - ##### 19:36:43 INFO - ##### Running install step. 19:36:43 INFO - ##### 19:36:43 INFO - Running pre-action listener: _resource_record_pre_action 19:36:43 INFO - Running main action method: install 19:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:43 INFO - Reading from file tmpfile_stdout 19:36:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:43 INFO - Reading from file tmpfile_stdout 19:36:43 INFO - Output received: 19:36:43 INFO - Usage: mozinstall [options] installer 19:36:43 INFO - Options: 19:36:43 INFO - -h, --help show this help message and exit 19:36:43 INFO - -d DEST, --destination=DEST 19:36:43 INFO - Directory to install application into. [default: 19:36:43 INFO - "/builds/slave/test"] 19:36:43 INFO - --app=APP Application being installed. [default: firefox] 19:36:43 INFO - mkdir: /builds/slave/test/build/application 19:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:37:00 INFO - Reading from file tmpfile_stdout 19:37:00 INFO - Output received: 19:37:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:37:00 INFO - Running post-action listener: _resource_record_post_action 19:37:00 INFO - ##### 19:37:00 INFO - ##### Finished install step (success) 19:37:00 INFO - ##### 19:37:00 INFO - ##### 19:37:00 INFO - ##### Running run-tests step. 19:37:00 INFO - ##### 19:37:00 INFO - Running pre-action listener: _resource_record_pre_action 19:37:00 INFO - Running main action method: run_tests 19:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:00 INFO - Python 2.7.3 19:37:00 INFO - Return code: 0 19:37:00 INFO - grabbing minidump binary from tooltool 19:37:00 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')]} 19:37:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a06f0>, '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 0x29a15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a1aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:00 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 19:37:00 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 19:37:00 INFO - Calling ['/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'] with output_timeout 600 19:37:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:01 INFO - Return code: 0 19:37:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:37:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:37:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:37:01 INFO - Return code: 0 19:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 19:37:01 INFO - Using env: {'DISPLAY': ':0', 19:37:01 INFO - 'HOME': '/home/cltbld', 19:37:01 INFO - 'LANG': 'en_US.UTF-8', 19:37:01 INFO - 'LANGUAGE': 'en_US:en', 19:37:01 INFO - 'LOGNAME': 'cltbld', 19:37:01 INFO - 'MAIL': '/var/mail/cltbld', 19:37:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:01 INFO - 'MOZ_NO_REMOTE': '1', 19:37:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:01 INFO - 'NO_EM_RESTART': '1', 19:37:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:01 INFO - 'PWD': '/builds/slave/test', 19:37:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:01 INFO - 'SHELL': '/bin/bash', 19:37:01 INFO - 'SHLVL': '1', 19:37:01 INFO - 'TERM': 'linux', 19:37:01 INFO - 'TMOUT': '86400', 19:37:01 INFO - 'USER': 'cltbld', 19:37:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621', 19:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:01 INFO - '_': '/tools/buildbot/bin/python'} 19:37:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 19:37:02 INFO - mozversion application_buildid: 20160627163033 19:37:02 INFO - mozversion application_changeset: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 19:37:02 INFO - mozversion application_display_name: Nightly 19:37:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:02 INFO - mozversion application_name: Firefox 19:37:02 INFO - mozversion application_remotingname: firefox 19:37:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:37:02 INFO - mozversion application_vendor: Mozilla 19:37:02 INFO - mozversion application_version: 50.0a1 19:37:02 INFO - mozversion platform_buildid: 20160627163033 19:37:02 INFO - mozversion platform_changeset: 7bcb335a9bc5bbbe6f7cdf5f8d507ebdb04ddf95 19:37:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:37:02 INFO - mozversion platform_version: 50.0a1 19:37:02 INFO - using testdate: 1467081422 19:37:02 INFO - actual date: 1467081422 19:37:02 INFO - starting webserver on 'localhost:43808' 19:37:02 INFO - SUITE-START | Running 2 tests 19:37:02 INFO - TEST-START | dromaeo_css 19:37:02 INFO - operating with platform_type : linux_ 19:37:02 INFO - Initialising browser for dromaeo_css test... 19:37:02 INFO - TEST-INFO | started process 9832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWXjsj/profile http://localhost:43808/getInfo.html) 19:37:07 INFO - PROCESS | 9832 | __metrics Screen width/height:1600/1200 19:37:07 INFO - PROCESS | 9832 | colorDepth:24 19:37:07 INFO - PROCESS | 9832 | Browser inner width/height: 1024/697 19:37:07 INFO - PROCESS | 9832 | __metrics 19:37:07 ERROR - PROCESS | 9832 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:37:08 INFO - TEST-INFO | 9832: exit 0 19:37:08 INFO - Browser initialized. 19:37:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:08 INFO - TEST-INFO | started process 9956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWXjsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:20 INFO - PROCESS | 9956 | RSS: Main: 168013824 19:37:20 INFO - PROCESS | 9956 | 19:38:10 INFO - PROCESS | 9956 | 1467081490071 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] 19:40:18 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43808/tests/dromaeo/cssquery-ext.html) 19:40:19 INFO - PROCESS | 9956 | RSS: Main: 170360832 19:40:19 INFO - PROCESS | 9956 | 19:43:22 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-ext.html (next: http://localhost:43808/tests/dromaeo/cssquery-jquery.html) 19:43:22 INFO - PROCESS | 9956 | RSS: Main: 170491904 19:43:22 INFO - PROCESS | 9956 | 19:46:24 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43808/tests/dromaeo/cssquery-mootools.html) 19:46:25 INFO - PROCESS | 9956 | RSS: Main: 171159552 19:46:25 INFO - PROCESS | 9956 | 19:49:27 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43808/tests/dromaeo/cssquery-prototype.html) 19:49:27 INFO - PROCESS | 9956 | RSS: Main: 169111552 19:49:27 INFO - PROCESS | 9956 | 19:52:30 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43808/tests/dromaeo/cssquery-yui.html) 19:52:30 INFO - PROCESS | 9956 | RSS: Main: 171241472 19:52:30 INFO - PROCESS | 9956 | 19:55:33 INFO - PROCESS | 9956 | Cycle 1(1): loaded http://localhost:43808/tests/dromaeo/cssquery-yui.html (next: http://localhost:43808/tests/dromaeo/cssquery-dojo.html) 19:55:34 INFO - PROCESS | 9956 | RSS: Main: 172310528 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | __start_tp_report 19:55:34 INFO - PROCESS | 9956 | _x_x_mozilla_page_load 19:55:34 INFO - PROCESS | 9956 | _x_x_mozilla_page_load_details 19:55:34 INFO - PROCESS | 9956 | |i|pagename|runs| 19:55:34 INFO - PROCESS | 9956 | |0;dojo.html;3129.827859467729;3137.4352616529018;3177.856996435161;3205.5672484214624;3214.7428205743545;5395.163749618806;5469.480399362059;5484.808031718891;5502.5597952163835;5555.638883472581;5340.62615616906;5525.060739674255;5547.278853749017;5625.099984002561;5649.689267090308;4993.101241776479;5020.0963826511215;5038.420581633104;5143.151380022292;5145.614078944075;5004.774785134678;5157.355330583677;5194.480551944795;5208.192730126836;5220.973895130538;4880.121578115955;4896.951030489685;4922.458529561745;5076.111680455924;5080.441151473335;4945.455999840015;4951.084049450863;4953.628477864175;4955.231939049453;4990.725510096943;4971.602271818246;4984.327115839352;4984.526469985346;4994.126027945095;5018.673786203885;5284.260203571503;5411.431799661058;5415.350157981028;5469.56243500519;5505.862353441156;5832.329282132567;5854.18041474194;5867.677277749722;5873.970630146865;5882.55880808941;5703.971480142614;5905.645661260338;5918.23063001807;5923.822285331447;5929.495992840613;5480.04099282624;5496.532794712454;5524.972375138139;5541.501264886179;5553.305836770363;6069.9089513656445;6069.908951365733;6070.210872586624;6072.36240194782;6086.239220097488;5660.8867822643315;5794.8551286217335;5823.330317013598;5825.4174582542255;5829.717462158318;5878.5297176225795;5943.881122377615;5956.315023772322;5967.46292833647;6001.339852616209;5615.382307946123;5698.373178950312;5726.3700992890745;5903.439173278532;5908.852278693067;5757.539396848242;5790.247267855152;5839.0949402842625;5853.443922827325;5873.148393482921;4275.1022285319805;4350.456192975878;4377.058932329501;4377.737335759864;4385.912281754411;3897.7271590988357;3916.3929590913453;3944.6449819516383;3958.346872766019;3959.1685745993086;5636.408177141423;5655.519280861091;5659.434056594308;5669.177969194526;5682.204491371212;5758.62568933018;5891.675957822361;5953.047512398082;5959.4934430573885;5970.791022314198;5631.493165615114;5675.602707810413;5683.147527870852;5684.744186511617;5691.317041954909;4794;4971.552560269593;4988.276699878497;4998.612047428357;5043.243513472935;6061.818145455643;6070.544709146831;6096.329403765582;6120.846978825476;6130.417610327012;5955.344912059583;5958;5964.731587078505;5967.104934259895;5967.46292833647;5967.104934259895;6079.057746049192;6107.9389206109145;6127.816165515042;6142.662153581596;5810.6513609183585;5814.418558144321;5817.069268916953;5817.360090389969;5866.325372582208;5868.94131058684;5906;5924.763009479572;5927.288725352985;5929.792457263975;5567.916481252865;5705.771769129188;5706.514946229617;5707.771689132388;5748.022836117953;5579.721013949367;5702.287214098238;5724.198612194213;5773.769049237983;5838.562107842014;5650.68921209321;5672;5708.286464191976;5719.685417302088;5721.942780572141;5676.602637815478;5733.885322293614;5743.282089738783;5747.821696552113;5824.650520968756;5599.440055994368;5611.7194140292;5658.17956396312;5726.255586773693;5753.827385178284 19:55:34 INFO - PROCESS | 9956 | |1;ext.html;568.3151802078496;628.2774808969684;633.9968300158496;643.6170478565252;648.2350826025288;36418;40695.186096278056;40984.59015409845;41183;41281;41566;42260.57739422605;42317.7884110579;42320.365194522106;42396.66818324991;8872.201501864814;9030.142136497023;9033;9037.728868133967;9045.005049444555;8862.734117976472;8934.597943092544;8935.55322233889;8938.687145949893;8940.910590894106;8984.8652270216;8997.640094396216;9036.728898133033;9065.501397423139;9092.954535227314;8941.50821704806;8952.283817294601;8958.283337332998;9002.86495702565;9005.054469280696;8945.418547794372;8988.77528061797;9011.27909767217;9030.50332231727;9038.54807259641;33526.49710254348;40141.19717605661;40232;40446;40461;3135.1535085527007;3306.7354611631013;3377.206356506219;3463.619001909788;3546.131197856516;30474.69525304741;30722.078337649906;30773.38453230923;31017;32008.199795005312;3851.614838516154;3874.4769456123345;3917.216556688674;4041.8585349512628;4078.4290199372113;305490;306958;307228;307258;308063.4596827024;32033.359332813678;32340.35319293601;32440.188995275308;32456.35087298288;32516.83741581277;32872.671273286964;33364.3327133456;33442.665573343955;33576.1605959853;34537.48193777095;17388.65222695539;17490.387836425663;17591.120443978005;17596.824031759774;17608.735868961976;13456.327183640975;13575.456981720818;13607.251601162032;13638.590842274747;13665.453381864614;19224.72316854851;19400.32098876561;19438.70841937372;19492;19554.608907821763;7102.5028248022145;7185.676644550903;7221.89167162493;7329.486935914541;7500.174980752113;996.5216695985822;1000.7097941596855;1092.8743194532572;1154.1171004181808;1196.682879037056;32731;32884;33001.3399732004;33492.49761253583;33707.157321066676;1071.5231721883843;1127.2729089737074;1173.3663821536445;1190.3810018790355;1203.5005472728894;17198.31206751716;17459.912700436416;17486.86523582993;17537.473875783748;18033.639327213645;514951;517272;519705;519750;524148;57914.420855791745;57945.42054579485;58227.70886145542;58243.12635310474;58492;1336.672515233774;1396.322783450026;1404.0452492305126;1417.893657975656;1421.8862491000696;31966.84016579902;33121.33757324792;33278;33396.1650958728;33905.15237119092;49161.508384915694;49811.501884982135;50148;50220.497795023046;50461.747691261306;468733;471877;475467;477365;478947;24899.37751556153;25113.24660260195;25696.229113126636;25770.35574110662;25951.22146335613;46600.30099548442;46610.13559457584;46982.76508617435;47451;47689.52310476851;38899;40484.19031619292;40769.59230407658;40883.18233635251;41104.38343424791;39547.40678889876;40496;40763.1847363057;40841.38737918993;41022;39739.40390894197;40275;40303;40366.59633403629;40441.59558404496;33851.83074084712;35762.8211858939;36246.818765906;36277.09307267339;36421.635783641825;27396.58905116385;27473.86263068672;27524.862375687993;27916.581251281652;27962.440751184455 19:55:34 INFO - PROCESS | 9956 | |2;jquery.html;365.2311883485264;382.3137468244501;382.6192938026664;387.2255489021956;397.67986770649617;17610.82389176108;19327;19494.415167544998;19497.902510487445;19698.507537311576;18156;18249.543761405937;18998.2400703972;19132.23471061156;19138;5225;5647.604667673254;5806.216160818278;5853.50245229156;5856.73644685988;5528.087865502187;5631.267935168423;5645.294338207724;5646.830595082154;5651.491365777079;5545.473180047889;6225.221847269091;6412.967935160318;6414.198225221848;6423.775167869126;6309.621422714606;6325.683715814214;6358.173437453124;6393.840153996187;6396.328385519523;5526.226328314039;5633.155026746021;5643;5660;5661.716914154275;11907.464164112636;11982.580609678707;22156.556868862695;22290.219842305603;22377;2206.7572567017614;2323.8257130715097;2326.3718795925174;2379.3337865397716;2776.319801648609;9767.609295628166;9793.755156121082;9936;10872;14399.344075431354;1912.9330473433502;1952.2581419060666;1957.862949593529;1976.505873531617;1999.7600287965392;76600.61699691521;79552;80403.59798200971;80500.59749701273;81775;10340.44893266001;10729;10762.24664273509;10875.673729788119;10917.290376125686;14792.334344954503;14818.555443336718;14890;14909.70180596382;14919.477818276308;7729.806754831175;8009.959950200212;8020.679172833022;8169.877451838227;8240.50556966584;7799.259070388304;7803.102643196105;7819.765407037798;7887.763367098996;7970.568976462235;4580.4045474088825;4597.609203217697;4626.629869610423;4651.651126165551;4728.290756386569;1925.422373288008;1949.210569719266;2014.1540552967788;2015.2140665140607;2022.7876073012417;909.6179604565966;1010.4240582867842;1030.922680798943;1042.0517329230515;1049.1763965287214;19455.805441945682;19532.90233548823;19731.60536789256;19885.204591816455;20012.39962801089;934.359963425056;940.5485367023867;954.656323723459;966.4732720667254;972.3242346569067;10562.202495818805;11094;11151.553937842395;11179.385133817717;11271.718207044725;404269;406636;443685;445039;446869;73569;81869.59065204755;83118.58440707758;94953;96895.51552242193;1002.333448256901;1014.0265345268477;1039.4127318065268;1061.5753698520653;1064.6965614799744;17582.38461653836;17779.46661600154;18133.546661333574;18255.726164107284;18619.255229790655;33535.496967545994;40441.98895027648;41259.793701032504;45464.77267613641;45561.54438455573;61056.389436106845;61654.38345616486;62511;62978.68510657417;64116;8289.378296627656;8481.15188481147;8770.342224333328;8805.955970220108;8872.157145071207;9824.901750982399;14035.087719298213;14147.221902795445;14522.273886305853;14567.635809104857;11903.583374581847;12126.878731212575;12182.817257740964;12257.754844903231;12349.19730217533;11371.54513819438;11597.75018232347;11634;11925.880741192477;12315.568955086528;12408.689782755504;12491.625251242478;12537.623871283877;12554.937225313815;12921.935390323364;7438.033055702724;8337.666493340199;8395.580220988804;8535.231829135408;8669.263112635497;11584.131190160602;11864.703382415508;12147.088968327587;12493.687657808265;12536.997040236942 19:55:34 INFO - PROCESS | 9956 | |3;mootools.html;1455.6943041961188;1458.8687018168362;1553.3708847916591;1650.306871114132;1672.8494435500802;7339.743108991173;8171.8365632687455;8233.547154906477;8725.738227853166;8729;8292.626831792568;8511.489310641366;8533.701320453785;8580.184882436159;8595.699150529732;2331.9766802332015;2353.0470159585393;2369.845960012594;2370.3718514593647;2380.5357955198742;2300.401895507172;2304.5275718477674;2345.906163753448;2382.130522359335;2389.1160270699866;2321.6401457774073;2328.208409140892;2343.3907184132077;2346.7301260355107;2368.2421625079983;2276.226083131743;2285.0859656137513;2289.9656505152434;2295.2655150351893;2296.2307626944994;2242.1367773407355;2253.312739614417;2253.9549209015727;2255.819534437241;2260.785225403584;8575.485470871705;8613.353998450142;8654.09132041133;8656.523891185981;8672.13278672134;5014.047331007097;5093.159628661267;5127.410347810012;5129.153689641204;5151.665141765773;3201.295714942709;3294.7199488043543;3346.196912740949;3349.346877358916;3399.963011281558;1059.1579694143174;1064.6007747094839;1071.6088627650852;1083.1118482844072;1086.9239153259275;11814.704632384173;11870.52517899283;11873.881261187364;11894.643160705193;11901.226420282654;4524.954750452519;4549.499555048942;4583.587477127075;4626.421697287839;4638.7216766993415;9933.50332483373;9997.900020999843;10011.299209055442;10014.64948726791;10029.247806414402;5173.379194496684;5176.068307704574;5181.5854731621375;5181.870453238699;5226.895462090737;4059.2287465381482;4587.9541204588195;4694.600958918462;4706.435227772689;4722;3808.5810560838286;3909.4917660703927;3937.684985201177;3981.5023122109737;3998.8400463981116;1236.2458900070949;1239.1202246404973;1240.0637518673343;1245.4333278358324;1247.3077442019585;985.3152059318704;1003.062136901999;1007.4005966449951;1011.2516737614112;1022.7698767777191;5882;5930.940690593039;5970.223870896755;6005;6159.414855588712;961.2262128986233;964.6880242869692;965.8744363232735;989.312427862643;1014.852846337277;4085.836566537365;4291.356296555479;4339.848105316299;4349.13017396522;4387.407699960529;9883.555240014217;10011.949940250252;10145.492725363702;10158.542865571068;10183.949080254552;10079.64721234768;10090.99090090985;10102.69691909244;10112.949435252776;10153.441560714084;7493.325600695964;7830.608469576612;7971.960140199378;8121.390895682847;8132.674693012332;5956.5462613113705;6068.21113255274;6127.785527506694;6204.7828326008375;6283.3716628338625;9858.654947076819;9863.210943124677;9930.751731206778;9931.900680993098;9964.302498825013;9708.85436718464;9817.55820988043;10054.597816087275;10113.797724045626;10158.187345012233;6677.866442671022;7219.169795473587;7485.47601667878;7514.098308203051;7652.120006199359;8136.0643525995265;8143.104258531675;8208.712695055645;8209;8217.219364160395;7152;7426.665800039119;7533.284337987882;7538;7647.464677472523;7335.77992660221;7412.258774122544;7445.367143792838;7454.92545074564;7569.243075692387;6943.618101004493;6964.686589103604;6965.303469652994;6989.266127056586;6998.370146686822;4963.429205641398;5026.798928042837;5127;5299.417064122867;5359.544438722753;5278.287431196739;5305.495977882095;5391.541718953933;5522.641028333145;5589.720513974204 19:55:34 INFO - PROCESS | 9956 | |4;prototype.html;314.2614855090536;322.1366737144453;324.6866425309622;327.4891169775151;331.78102452381404;5561.360443548993;5657.236273103135;5705.229793977806;5728.25532680752;5730.283714535683;5539.362973258077;5577.498025177733;5580.386157522669;5581.665100093997;5587.357453892803;4307.3969644249755;4317.373980772786;4342.392065110887;4352.194843953878;4354.95481084539;4275.914481710364;4298.376735373369;4305.720128191673;4343.109662519192;4357.782110894458;4229.598188172119;4235.597618226264;4239.491261048678;4260.808263628144;4293.613574778269;4290.334998075287;4303.35449682547;4303.720258183223;4308.719933204332;4322.157179349996;3630.981845090784;3736.8229007862437;3750.706006427778;3761.153740408414;3766.133789228493;5458.754356053987;5484.177373393983;5503.807366742145;5509.889802203974;5517.310336207974;4880.6095512358925;4885.2427873679635;4889.779959901813;4890.951090489085;4959.950400495985;5683.277453268116;5845.883082338372;5881.823725221695;5882.735276912549;5886.352501224862;4103.6252855293515;4107.753534787892;4114;4115.156392939441;4126.277901367249;5781.19063331134;6005.309389420229;6101.047664747282;6163.476104531121;6166.321704612489;4099.221147981874;4137.97931010349;4143.129942712004;4163.854265100767;4178.101708132705;4229.619334259932;4239.109786944715;4246.299360605527;4246.341817018305;4280.229558679405;4667.789949452283;4950.480199578992;4952.851414457572;4958.355413796184;4962.255661650709;5959.791407300723;5966.910496342558;5977.880442391215;5983.820485385445;6018.277806663141;1452.9128252304895;1468.8898332625097;1477.0546850015999;1487.375302373006;1488.8312674550643;900.7029876977132;919.6229545886289;928.9489078100634;937.5593471068587;948.672707915768;5013.197888337849;5038.521340472649;5041.344625198701;5076.806950366661;5081.119985605275;5352.584118102581;5356.384015838151;5375;5450.400455949843;5453.364640055921;4907.411110666671;5122.201805860181;5171.50870667286;5183.585313174937;5202.167653175549;2961.304093538017;2969.5248760198697;2971.85140742962;2974.824944147093;2985.9399913030998;5619.325680918316;5632.605717599728;5664.716764161775;5696.857578560486;5705.31850030485;5337.8131765388025;5398.379186393537;5543.473370029841;5546.722663866791;5583.720813959286;5434.956424402348;5500.642458240201;5515.227868098469;5562.276904002454;5587.563648356313;5276.70978096193;5362.785488580413;5474.39781624029;5477.75350109238;5507.375324279267;5365.865853353697;5389.622726409114;5441.945580544144;5458.6724796512335;5462.661647896291;6060.909086363797;6139.785107521216;6189.288231853395;6246.593971391845;6283.874322513433;4165.396017577495;4181.330987042059;4181.853635122756;4189.350650649154;4192.119654872511;5908.793192238423;6079.209702738615;6089.5737298388685;6101.054336577838;6114.327423983447;5876.647401155773;5917.556183286357;5938.940610593839;5946.970265148647;5967.373425790403;5803.187553742564;5886.764529418775;5920.230370051866;5963.70181490915;6008.369121242382;5708.686022268815;5823.388544202798;5896.145058966512;5931.703414829155;5942.702864856654;5947.940520594739;5957.642541447527;5974.701264936649;6016.2780466342565;6032.547558933185;5677.630953987978;5816.389279125631;5817.825465236049;5819.79630712923;5855.677937713296 19:55:34 INFO - PROCESS | 9956 | |5;yui.html;733.1056111543915;753.5817621220223;767.202109805802;791.1692722641226;803.4857691077708;14814.407423703038;14857.182854942974;15327.616809579738;15757.527274181779;15781.84218157818;14801.11193328401;15040.247987600631;15045.548633541011;15176.544703658881;15191.924040379783;787.9330256928168;795.892554505143;798.636620337745;799.7161007842219;801.2748462641318;786.9213078692113;797.3541431440523;818.6684392820918;821.3880658909121;823.8558252305852;845.3786466946789;847.3644766425181;848.9066202717696;851.693390379466;852.8081181734091;839.4040231435657;842.0148426341195;843.0347252396003;844.6705784743955;847.1486156412766;614.8493619063358;615.7198474694003;616.4020899727258;619.4239357397619;620.950323974081;15567.37730490779;15654.45209417665;15671.294791734284;15794.684106317809;15809.051456912623;14435.13389196641;14444.57754352337;14526.927365363106;14643.487477938328;14679.77980330296;12242.693932651666;12250.326232057234;12342.691432714253;12493.437795299233;12547.372631368395;3900.551436584772;3947.072437977073;3968.7817170055637;4046.59534046593;4068.7151899367054;80076.59961700212;80649.19350806533;80996;80996.19003810005;81452.59273703594;11016.834747478793;11230.438478076063;11466.31202127875;11810.763784724257;12131.96523442779;21645.567088658452;22573;22890.885545572164;22950;23001.079956801874;8873;8899.599518021705;8909.331800114887;8990;9158.129977652112;4879.634027447884;4882.998985208023;4919.4834542373255;4977.601791856715;5038.773255203525;3497.527833742412;3587.4260118380935;3652.2695460907926;3664.486971823947;3929.44987701722;720.621673621353;734.0164179998827;742.0501757750088;747.2975403121048;764.0602059466776;626.2328647406981;704.3977399323607;705.3968856627612;709.9964500177466;721.9314165154302;10012.799744005224;10026.398416095057;10349.275550711378;10519.00069493397;10737.463126843626;679.2935347238816;685.9897101543481;689.8620275944832;733.8275505256261;776.343989329016;4839.225723884161;4850.854474365775;5002.399712034579;5015.172496538104;5134.845954621367;104797;106237.46881265544;106699.46650266854;107519.46240268748;110088;88137.55931220303;92103.53948230216;92945.5352723232;96691;99439;85552.57223713966;86100.13899861046;86873.1312686865;88645;88932.11067889238;9484.95257523708;9507.952460237655;9547.188488978236;9637.951810240904;9714;50059;50060.49939500704;51149.488505114474;52726.20910686266;53327.466725333805;66681.33318666945;75277.24722752921;75286.62356688401;75703.24296756962;75922;12042.277463352228;12141.878581214074;12403.13178077562;12417.19288246261;12962.22226666403;13959.860401395856;14029.368678409292;14321.28393580296;14392.28038598045;14603.415863365346;12885.226886386847;13144.145630533985;13306;13592.11651242666;13656.522021729192;12902.969194359877;13115.27865967381;13401.195928244337;13652.658683532594;13811.585652430444;11459.541618335506;12323.938380308042;12566.37168141571;13583.79624305656;14148.646283842987;11846.407679616157;12037.939810300892;12238.204516706386;12408.56570020045;12491.812622810847;11753.412329383667;12065.81901271464;12107.152499324962;12203.877961220274;12292.261766264026 19:55:34 INFO - PROCESS | 9956 | __end_tp_report 19:55:34 INFO - PROCESS | 9956 | __start_cc_report 19:55:34 INFO - PROCESS | 9956 | _x_x_mozilla_cycle_collect,347 19:55:34 INFO - PROCESS | 9956 | __end_cc_report 19:55:34 INFO - PROCESS | 9956 | __startTimestamp1467082534160__endTimestamp 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | ------- Summary: start ------- 19:55:34 INFO - PROCESS | 9956 | Number of tests: 6 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#0] dojo.html Cycles:165 Average:5463.80 Median:5683.15 stddev:638.33 (11.2%) stddev-sans-first:613.46 19:55:34 INFO - PROCESS | 9956 | Values: 3129.8 3137.4 3177.9 3205.6 3214.7 5395.2 5469.5 5484.8 5502.6 5555.6 5340.6 5525.1 5547.3 5625.1 5649.7 4993.1 5020.1 5038.4 5143.2 5145.6 5004.8 5157.4 5194.5 5208.2 5221.0 4880.1 4897.0 4922.5 5076.1 5080.4 4945.5 4951.1 4953.6 4955.2 4990.7 4971.6 4984.3 4984.5 4994.1 5018.7 5284.3 5411.4 5415.4 5469.6 5505.9 5832.3 5854.2 5867.7 5874.0 5882.6 5704.0 5905.6 5918.2 5923.8 5929.5 5480.0 5496.5 5525.0 5541.5 5553.3 6069.9 6069.9 6070.2 6072.4 6086.2 5660.9 5794.9 5823.3 5825.4 5829.7 5878.5 5943.9 5956.3 5967.5 6001.3 5615.4 5698.4 5726.4 5903.4 5908.9 5757.5 5790.2 5839.1 5853.4 5873.1 4275.1 4350.5 4377.1 4377.7 4385.9 3897.7 3916.4 3944.6 3958.3 3959.2 5636.4 5655.5 5659.4 5669.2 5682.2 5758.6 5891.7 5953.0 5959.5 5970.8 5631.5 5675.6 5683.1 5684.7 5691.3 4794.0 4971.6 4988.3 4998.6 5043.2 6061.8 6070.5 6096.3 6120.8 6130.4 5955.3 5958.0 5964.7 5967.1 5967.5 5967.1 6079.1 6107.9 6127.8 6142.7 5810.7 5814.4 5817.1 5817.4 5866.3 5868.9 5906.0 5924.8 5927.3 5929.8 5567.9 5705.8 5706.5 5707.8 5748.0 5579.7 5702.3 5724.2 5773.8 5838.6 5650.7 5672.0 5708.3 5719.7 5721.9 5676.6 5733.9 5743.3 5747.8 5824.7 5599.4 5611.7 5658.2 5726.3 5753.8 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#1] ext.html Cycles:180 Average:57839.05 Median:39643.41 stddev:117717.91 (296.9%) stddev-sans-first:117969.61 19:55:34 INFO - PROCESS | 9956 | Values: 568.3 628.3 634.0 643.6 648.2 36418.0 40695.2 40984.6 41183.0 41281.0 41566.0 42260.6 42317.8 42320.4 42396.7 8872.2 9030.1 9033.0 9037.7 9045.0 8862.7 8934.6 8935.6 8938.7 8940.9 8984.9 8997.6 9036.7 9065.5 9093.0 8941.5 8952.3 8958.3 9002.9 9005.1 8945.4 8988.8 9011.3 9030.5 9038.5 33526.5 40141.2 40232.0 40446.0 40461.0 3135.2 3306.7 3377.2 3463.6 3546.1 30474.7 30722.1 30773.4 31017.0 32008.2 3851.6 3874.5 3917.2 4041.9 4078.4 305490.0 306958.0 307228.0 307258.0 308063.5 32033.4 32340.4 32440.2 32456.4 32516.8 32872.7 33364.3 33442.7 33576.2 34537.5 17388.7 17490.4 17591.1 17596.8 17608.7 13456.3 13575.5 13607.3 13638.6 13665.5 19224.7 19400.3 19438.7 19492.0 19554.6 7102.5 7185.7 7221.9 7329.5 7500.2 996.5 1000.7 1092.9 1154.1 1196.7 32731.0 32884.0 33001.3 33492.5 33707.2 1071.5 1127.3 1173.4 1190.4 1203.5 17198.3 17459.9 17486.9 17537.5 18033.6 514951.0 517272.0 519705.0 519750.0 524148.0 57914.4 57945.4 58227.7 58243.1 58492.0 1336.7 1396.3 1404.0 1417.9 1421.9 31966.8 33121.3 33278.0 33396.2 33905.2 49161.5 49811.5 50148.0 50220.5 50461.7 468733.0 471877.0 475467.0 477365.0 478947.0 24899.4 25113.2 25696.2 25770.4 25951.2 46600.3 46610.1 46982.8 47451.0 47689.5 38899.0 40484.2 40769.6 40883.2 41104.4 39547.4 40496.0 40763.2 40841.4 41022.0 39739.4 40275.0 40303.0 40366.6 40441.6 33851.8 35762.8 36246.8 36277.1 36421.6 27396.6 27473.9 27524.9 27916.6 27962.4 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#2] jquery.html Cycles:180 Average:27193.91 Median:16950.36 stddev:71135.91 (419.7%) stddev-sans-first:71306.95 19:55:34 INFO - PROCESS | 9956 | Values: 365.2 382.3 382.6 387.2 397.7 17610.8 19327.0 19494.4 19497.9 19698.5 18156.0 18249.5 18998.2 19132.2 19138.0 5225.0 5647.6 5806.2 5853.5 5856.7 5528.1 5631.3 5645.3 5646.8 5651.5 5545.5 6225.2 6413.0 6414.2 6423.8 6309.6 6325.7 6358.2 6393.8 6396.3 5526.2 5633.2 5643.0 5660.0 5661.7 11907.5 11982.6 22156.6 22290.2 22377.0 2206.8 2323.8 2326.4 2379.3 2776.3 9767.6 9793.8 9936.0 10872.0 14399.3 1912.9 1952.3 1957.9 1976.5 1999.8 76600.6 79552.0 80403.6 80500.6 81775.0 10340.4 10729.0 10762.2 10875.7 10917.3 14792.3 14818.6 14890.0 14909.7 14919.5 7729.8 8010.0 8020.7 8169.9 8240.5 7799.3 7803.1 7819.8 7887.8 7970.6 4580.4 4597.6 4626.6 4651.7 4728.3 1925.4 1949.2 2014.2 2015.2 2022.8 909.6 1010.4 1030.9 1042.1 1049.2 19455.8 19532.9 19731.6 19885.2 20012.4 934.4 940.5 954.7 966.5 972.3 10562.2 11094.0 11151.6 11179.4 11271.7 404269.0 406636.0 443685.0 445039.0 446869.0 73569.0 81869.6 83118.6 94953.0 96895.5 1002.3 1014.0 1039.4 1061.6 1064.7 17582.4 17779.5 18133.5 18255.7 18619.3 33535.5 40442.0 41259.8 45464.8 45561.5 61056.4 61654.4 62511.0 62978.7 64116.0 8289.4 8481.2 8770.3 8806.0 8872.2 9824.9 14035.1 14147.2 14522.3 14567.6 11903.6 12126.9 12182.8 12257.8 12349.2 11371.5 11597.8 11634.0 11925.9 12315.6 12408.7 12491.6 12537.6 12554.9 12921.9 7438.0 8337.7 8395.6 8535.2 8669.3 11584.1 11864.7 12147.1 12493.7 12537.0 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#3] mootools.html Cycles:180 Average:5658.10 Median:4988.74 stddev:3129.50 (62.7%) stddev-sans-first:3122.34 19:55:34 INFO - PROCESS | 9956 | Values: 1455.7 1458.9 1553.4 1650.3 1672.8 7339.7 8171.8 8233.5 8725.7 8729.0 8292.6 8511.5 8533.7 8580.2 8595.7 2332.0 2353.0 2369.8 2370.4 2380.5 2300.4 2304.5 2345.9 2382.1 2389.1 2321.6 2328.2 2343.4 2346.7 2368.2 2276.2 2285.1 2290.0 2295.3 2296.2 2242.1 2253.3 2254.0 2255.8 2260.8 8575.5 8613.4 8654.1 8656.5 8672.1 5014.0 5093.2 5127.4 5129.2 5151.7 3201.3 3294.7 3346.2 3349.3 3400.0 1059.2 1064.6 1071.6 1083.1 1086.9 11814.7 11870.5 11873.9 11894.6 11901.2 4525.0 4549.5 4583.6 4626.4 4638.7 9933.5 9997.9 10011.3 10014.6 10029.2 5173.4 5176.1 5181.6 5181.9 5226.9 4059.2 4588.0 4694.6 4706.4 4722.0 3808.6 3909.5 3937.7 3981.5 3998.8 1236.2 1239.1 1240.1 1245.4 1247.3 985.3 1003.1 1007.4 1011.3 1022.8 5882.0 5930.9 5970.2 6005.0 6159.4 961.2 964.7 965.9 989.3 1014.9 4085.8 4291.4 4339.8 4349.1 4387.4 9883.6 10011.9 10145.5 10158.5 10183.9 10079.6 10091.0 10102.7 10112.9 10153.4 7493.3 7830.6 7972.0 8121.4 8132.7 5956.5 6068.2 6127.8 6204.8 6283.4 9858.7 9863.2 9930.8 9931.9 9964.3 9708.9 9817.6 10054.6 10113.8 10158.2 6677.9 7219.2 7485.5 7514.1 7652.1 8136.1 8143.1 8208.7 8209.0 8217.2 7152.0 7426.7 7533.3 7538.0 7647.5 7335.8 7412.3 7445.4 7454.9 7569.2 6943.6 6964.7 6965.3 6989.3 6998.4 4963.4 5026.8 5127.0 5299.4 5359.5 5278.3 5305.5 5391.5 5522.6 5589.7 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#4] prototype.html Cycles:180 Average:4792.69 Median:5446.17 stddev:1415.49 (26.0%) stddev-sans-first:1378.97 19:55:34 INFO - PROCESS | 9956 | Values: 314.3 322.1 324.7 327.5 331.8 5561.4 5657.2 5705.2 5728.3 5730.3 5539.4 5577.5 5580.4 5581.7 5587.4 4307.4 4317.4 4342.4 4352.2 4355.0 4275.9 4298.4 4305.7 4343.1 4357.8 4229.6 4235.6 4239.5 4260.8 4293.6 4290.3 4303.4 4303.7 4308.7 4322.2 3631.0 3736.8 3750.7 3761.2 3766.1 5458.8 5484.2 5503.8 5509.9 5517.3 4880.6 4885.2 4889.8 4891.0 4960.0 5683.3 5845.9 5881.8 5882.7 5886.4 4103.6 4107.8 4114.0 4115.2 4126.3 5781.2 6005.3 6101.0 6163.5 6166.3 4099.2 4138.0 4143.1 4163.9 4178.1 4229.6 4239.1 4246.3 4246.3 4280.2 4667.8 4950.5 4952.9 4958.4 4962.3 5959.8 5966.9 5977.9 5983.8 6018.3 1452.9 1468.9 1477.1 1487.4 1488.8 900.7 919.6 928.9 937.6 948.7 5013.2 5038.5 5041.3 5076.8 5081.1 5352.6 5356.4 5375.0 5450.4 5453.4 4907.4 5122.2 5171.5 5183.6 5202.2 2961.3 2969.5 2971.9 2974.8 2985.9 5619.3 5632.6 5664.7 5696.9 5705.3 5337.8 5398.4 5543.5 5546.7 5583.7 5435.0 5500.6 5515.2 5562.3 5587.6 5276.7 5362.8 5474.4 5477.8 5507.4 5365.9 5389.6 5441.9 5458.7 5462.7 6060.9 6139.8 6189.3 6246.6 6283.9 4165.4 4181.3 4181.9 4189.4 4192.1 5908.8 6079.2 6089.6 6101.1 6114.3 5876.6 5917.6 5938.9 5947.0 5967.4 5803.2 5886.8 5920.2 5963.7 6008.4 5708.7 5823.4 5896.1 5931.7 5942.7 5947.9 5957.6 5974.7 6016.3 6032.5 5677.6 5816.4 5817.8 5819.8 5855.7 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - PROCESS | 9956 | [#5] yui.html Cycles:180 Average:20696.39 Median:4845.04 stddev:29128.23 (601.2%) stddev-sans-first:29171.38 19:55:34 INFO - PROCESS | 9956 | Values: 733.1 753.6 767.2 791.2 803.5 14814.4 14857.2 15327.6 15757.5 15781.8 14801.1 15040.2 15045.5 15176.5 15191.9 787.9 795.9 798.6 799.7 801.3 786.9 797.4 818.7 821.4 823.9 845.4 847.4 848.9 851.7 852.8 839.4 842.0 843.0 844.7 847.1 614.8 615.7 616.4 619.4 621.0 15567.4 15654.5 15671.3 15794.7 15809.1 14435.1 14444.6 14526.9 14643.5 14679.8 12242.7 12250.3 12342.7 12493.4 12547.4 3900.6 3947.1 3968.8 4046.6 4068.7 80076.6 80649.2 80996.0 80996.2 81452.6 11016.8 11230.4 11466.3 11810.8 12132.0 21645.6 22573.0 22890.9 22950.0 23001.1 8873.0 8899.6 8909.3 8990.0 9158.1 4879.6 4883.0 4919.5 4977.6 5038.8 3497.5 3587.4 3652.3 3664.5 3929.4 720.6 734.0 742.1 747.3 764.1 626.2 704.4 705.4 710.0 721.9 10012.8 10026.4 10349.3 10519.0 10737.5 679.3 686.0 689.9 733.8 776.3 4839.2 4850.9 5002.4 5015.2 5134.8 104797.0 106237.5 106699.5 107519.5 110088.0 88137.6 92103.5 92945.5 96691.0 99439.0 85552.6 86100.1 86873.1 88645.0 88932.1 9485.0 9508.0 9547.2 9638.0 9714.0 50059.0 50060.5 51149.5 52726.2 53327.5 66681.3 75277.2 75286.6 75703.2 75922.0 12042.3 12141.9 12403.1 12417.2 12962.2 13959.9 14029.4 14321.3 14392.3 14603.4 12885.2 13144.1 13306.0 13592.1 13656.5 12903.0 13115.3 13401.2 13652.7 13811.6 11459.5 12323.9 12566.4 13583.8 14148.6 11846.4 12037.9 12238.2 12408.6 12491.8 11753.4 12065.8 12107.2 12203.9 12292.3 19:55:34 INFO - PROCESS | 9956 | -------- Summary: end -------- 19:55:34 INFO - PROCESS | 9956 | 19:55:34 INFO - TEST-INFO | 9956: exit 0 19:55:34 INFO - TEST-OK | dromaeo_css | took 1112795ms 19:55:34 INFO - TEST-START | kraken 19:55:34 INFO - operating with platform_type : linux_ 19:55:34 INFO - Initialising browser for kraken test... 19:55:34 INFO - TEST-INFO | started process 10191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PDllg/profile http://localhost:43808/getInfo.html) 19:55:39 INFO - PROCESS | 10191 | __metrics Screen width/height:1600/1200 19:55:39 INFO - PROCESS | 10191 | colorDepth:24 19:55:39 INFO - PROCESS | 10191 | Browser inner width/height: 1024/697 19:55:39 INFO - PROCESS | 10191 | __metrics 19:55:40 ERROR - PROCESS | 10191 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:55:41 INFO - TEST-INFO | 10191: exit 0 19:55:41 INFO - Browser initialized. 19:55:41 INFO - Running cycle 1/1 for kraken test... 19:55:41 INFO - TEST-INFO | started process 10311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1PDllg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:53 INFO - PROCESS | 10311 | RSS: Main: 168468480 19:55:53 INFO - PROCESS | 10311 | 19:55:55 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43808/tests/kraken/driver.html?testName=audio-beat-detection) 19:55:56 INFO - PROCESS | 10311 | RSS: Main: 173584384 19:55:56 INFO - PROCESS | 10311 | 19:55:59 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43808/tests/kraken/driver.html?testName=audio-dft) 19:55:59 INFO - PROCESS | 10311 | RSS: Main: 172707840 19:55:59 INFO - PROCESS | 10311 | 19:56:02 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43808/tests/kraken/driver.html?testName=audio-fft) 19:56:03 INFO - PROCESS | 10311 | RSS: Main: 167550976 19:56:03 INFO - PROCESS | 10311 | 19:56:05 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43808/tests/kraken/driver.html?testName=audio-oscillator) 19:56:06 INFO - PROCESS | 10311 | RSS: Main: 168378368 19:56:06 INFO - PROCESS | 10311 | 19:56:08 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:09 INFO - PROCESS | 10311 | RSS: Main: 168534016 19:56:09 INFO - PROCESS | 10311 | 19:56:12 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43808/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:13 INFO - PROCESS | 10311 | RSS: Main: 169177088 19:56:13 INFO - PROCESS | 10311 | 19:56:16 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43808/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:17 INFO - PROCESS | 10311 | RSS: Main: 166649856 19:56:17 INFO - PROCESS | 10311 | 19:56:19 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43808/tests/kraken/driver.html?testName=json-parse-financial) 19:56:20 INFO - PROCESS | 10311 | RSS: Main: 168116224 19:56:20 INFO - PROCESS | 10311 | 19:56:22 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:22 INFO - PROCESS | 10311 | RSS: Main: 168636416 19:56:22 INFO - PROCESS | 10311 | 19:56:24 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:25 INFO - PROCESS | 10311 | RSS: Main: 168820736 19:56:25 INFO - PROCESS | 10311 | 19:56:27 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:28 INFO - PROCESS | 10311 | RSS: Main: 169050112 19:56:28 INFO - PROCESS | 10311 | 19:56:30 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:31 INFO - PROCESS | 10311 | RSS: Main: 169639936 19:56:31 INFO - PROCESS | 10311 | 19:56:34 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:34 INFO - PROCESS | 10311 | RSS: Main: 169537536 19:56:34 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | Cycle 1(1): loaded http://localhost:43808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43808/tests/kraken/driver.html?testName=ai-astar) 19:56:36 INFO - PROCESS | 10311 | RSS: Main: 169922560 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | __start_tp_report 19:56:36 INFO - PROCESS | 10311 | _x_x_mozilla_page_load 19:56:36 INFO - PROCESS | 10311 | _x_x_mozilla_page_load_details 19:56:36 INFO - PROCESS | 10311 | |i|pagename|runs| 19:56:36 INFO - PROCESS | 10311 | |0;ai-astar;100;110;105;110;111;111;117;113;111;112 19:56:36 INFO - PROCESS | 10311 | |1;audio-beat-detection;157;139;157;182;137;162;169;137;192;129 19:56:36 INFO - PROCESS | 10311 | |2;audio-dft;163;163;161;163;163;169;170;162;163;164 19:56:36 INFO - PROCESS | 10311 | |3;audio-fft;74;75;77;153;76;76;76;75;166;76 19:56:36 INFO - PROCESS | 10311 | |4;audio-oscillator;86;86;144;85;85;85;150;85;86;158 19:56:36 INFO - PROCESS | 10311 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;119;117;117 19:56:36 INFO - PROCESS | 10311 | |6;imaging-darkroom;148;147;148;147;149;148;152;147;147;147 19:56:36 INFO - PROCESS | 10311 | |7;imaging-desaturate;96;96;97;96;95;96;96;96;95;95 19:56:36 INFO - PROCESS | 10311 | |8;json-parse-financial;61;59;59;59;59;59;59;58;59;58 19:56:36 INFO - PROCESS | 10311 | |9;json-stringify-tinderbox;60;62;62;62;64;61;61;62;62;62 19:56:36 INFO - PROCESS | 10311 | |10;stanford-crypto-aes;79;80;82;80;87;82;81;86;147;80 19:56:36 INFO - PROCESS | 10311 | |11;stanford-crypto-ccm;125;125;126;124;130;133;128;129;124;123 19:56:36 INFO - PROCESS | 10311 | |12;stanford-crypto-pbkdf2;167;177;166;162;161;171;163;164;161;169 19:56:36 INFO - PROCESS | 10311 | |13;stanford-crypto-sha256-iterative;68;68;65;65;68;68;64;66;63;63 19:56:36 INFO - PROCESS | 10311 | __end_tp_report 19:56:36 INFO - PROCESS | 10311 | __start_cc_report 19:56:36 INFO - PROCESS | 10311 | _x_x_mozilla_cycle_collect,897 19:56:36 INFO - PROCESS | 10311 | __end_cc_report 19:56:36 INFO - PROCESS | 10311 | __startTimestamp1467082596599__endTimestamp 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | ------- Summary: start ------- 19:56:36 INFO - PROCESS | 10311 | Number of tests: 14 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:4.59 (4.1%) stddev-sans-first:3.14 19:56:36 INFO - PROCESS | 10311 | Values: 100.0 110.0 105.0 110.0 111.0 111.0 117.0 113.0 111.0 112.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:159.50 stddev:20.87 (13.1%) stddev-sans-first:22.13 19:56:36 INFO - PROCESS | 10311 | Values: 157.0 139.0 157.0 182.0 137.0 162.0 169.0 137.0 192.0 129.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:2.96 (1.8%) stddev-sans-first:3.11 19:56:36 INFO - PROCESS | 10311 | Values: 163.0 163.0 161.0 163.0 163.0 169.0 170.0 162.0 163.0 164.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:35.51 (46.7%) stddev-sans-first:37.03 19:56:36 INFO - PROCESS | 10311 | Values: 74.0 75.0 77.0 153.0 76.0 76.0 76.0 75.0 166.0 76.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:85.00 stddev:31.69 (37.3%) stddev-sans-first:32.86 19:56:36 INFO - PROCESS | 10311 | Values: 86.0 86.0 144.0 85.0 85.0 85.0 150.0 85.0 86.0 158.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 19:56:36 INFO - PROCESS | 10311 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 119.0 117.0 117.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.56 (1.1%) stddev-sans-first:1.66 19:56:36 INFO - PROCESS | 10311 | Values: 148.0 147.0 148.0 147.0 149.0 148.0 152.0 147.0 147.0 147.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:56:36 INFO - PROCESS | 10311 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.44 19:56:36 INFO - PROCESS | 10311 | Values: 61.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 58.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:0.87 19:56:36 INFO - PROCESS | 10311 | Values: 60.0 62.0 62.0 62.0 64.0 61.0 61.0 62.0 62.0 62.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:81.50 stddev:20.76 (25.5%) stddev-sans-first:21.74 19:56:36 INFO - PROCESS | 10311 | Values: 79.0 80.0 82.0 80.0 87.0 82.0 81.0 86.0 147.0 80.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:3.20 (2.5%) stddev-sans-first:3.33 19:56:36 INFO - PROCESS | 10311 | Values: 125.0 125.0 126.0 124.0 130.0 133.0 128.0 129.0 124.0 123.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:5.11 (3.1%) stddev-sans-first:5.41 19:56:36 INFO - PROCESS | 10311 | Values: 167.0 177.0 166.0 162.0 161.0 171.0 163.0 164.0 161.0 169.0 19:56:36 INFO - PROCESS | 10311 | 19:56:36 INFO - PROCESS | 10311 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:67.00 stddev:2.10 (3.1%) stddev-sans-first:2.07 19:56:36 INFO - PROCESS | 10311 | Values: 68.0 68.0 65.0 65.0 68.0 68.0 64.0 66.0 63.0 63.0 19:56:36 INFO - PROCESS | 10311 | -------- Summary: end -------- 19:56:36 INFO - PROCESS | 10311 | 19:56:37 INFO - TEST-INFO | 10311: exit 0 19:56:37 INFO - TEST-OK | kraken | took 62709ms 19:56:37 INFO - SUITE-END | took 1175s 19:56:37 INFO - Completed test suite (00:19:35) 19:56:37 INFO - javascript benchmark 19:56:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7263.441640406588, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.827859467729, 3137.4352616529018, 3177.856996435161, 3205.5672484214624, 3214.7428205743545, 5395.163749618806, 5469.480399362059, 5484.808031718891, 5502.5597952163835, 5555.638883472581, 5340.62615616906, 5525.060739674255, 5547.278853749017, 5625.099984002561, 5649.689267090308, 4993.101241776479, 5020.0963826511215, 5038.420581633104, 5143.151380022292, 5145.614078944075, 5004.774785134678, 5157.355330583677, 5194.480551944795, 5208.192730126836, 5220.973895130538, 4880.121578115955, 4896.951030489685, 4922.458529561745, 5076.111680455924, 5080.441151473335, 4945.455999840015, 4951.084049450863, 4953.628477864175, 4955.231939049453, 4990.725510096943, 4971.602271818246, 4984.327115839352, 4984.526469985346, 4994.126027945095, 5018.673786203885, 5284.260203571503, 5411.431799661058, 5415.350157981028, 5469.56243500519, 5505.862353441156, 5832.329282132567, 5854.18041474194, 5867.677277749722, 5873.970630146865, 5882.55880808941, 5703.971480142614, 5905.645661260338, 5918.23063001807, 5923.822285331447, 5929.495992840613, 5480.04099282624, 5496.532794712454, 5524.972375138139, 5541.501264886179, 5553.305836770363, 6069.9089513656445, 6069.908951365733, 6070.210872586624, 6072.36240194782, 6086.239220097488, 5660.8867822643315, 5794.8551286217335, 5823.330317013598, 5825.4174582542255, 5829.717462158318, 5878.5297176225795, 5943.881122377615, 5956.315023772322, 5967.46292833647, 6001.339852616209, 5615.382307946123, 5698.373178950312, 5726.3700992890745, 5903.439173278532, 5908.852278693067, 5757.539396848242, 5790.247267855152, 5839.0949402842625, 5853.443922827325, 5873.148393482921, 4275.1022285319805, 4350.456192975878, 4377.058932329501, 4377.737335759864, 4385.912281754411, 3897.7271590988357, 3916.3929590913453, 3944.6449819516383, 3958.346872766019, 3959.1685745993086, 5636.408177141423, 5655.519280861091, 5659.434056594308, 5669.177969194526, 5682.204491371212, 5758.62568933018, 5891.675957822361, 5953.047512398082, 5959.4934430573885, 5970.791022314198, 5631.493165615114, 5675.602707810413, 5683.147527870852, 5684.744186511617, 5691.317041954909, 4794.0, 4971.552560269593, 4988.276699878497, 4998.612047428357, 5043.243513472935, 6061.818145455643, 6070.544709146831, 6096.329403765582, 6120.846978825476, 6130.417610327012, 5955.344912059583, 5958.0, 5964.731587078505, 5967.104934259895, 5967.46292833647, 5967.104934259895, 6079.057746049192, 6107.9389206109145, 6127.816165515042, 6142.662153581596, 5810.6513609183585, 5814.418558144321, 5817.069268916953, 5817.360090389969, 5866.325372582208, 5868.94131058684, 5906.0, 5924.763009479572, 5927.288725352985, 5929.792457263975, 5567.916481252865, 5705.771769129188, 5706.514946229617, 5707.771689132388, 5748.022836117953, 5579.721013949367, 5702.287214098238, 5724.198612194213, 5773.769049237983, 5838.562107842014, 5650.68921209321, 5672.0, 5708.286464191976, 5719.685417302088, 5721.942780572141, 5676.602637815478, 5733.885322293614, 5743.282089738783, 5747.821696552113, 5824.650520968756, 5599.440055994368, 5611.7194140292, 5658.17956396312, 5726.255586773693, 5753.827385178284], "value": 5419.4117438612775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3151802078496, 628.2774808969684, 633.9968300158496, 643.6170478565252, 648.2350826025288, 36418.0, 40695.186096278056, 40984.59015409845, 41183.0, 41281.0, 41566.0, 42260.57739422605, 42317.7884110579, 42320.365194522106, 42396.66818324991, 8872.201501864814, 9030.142136497023, 9033.0, 9037.728868133967, 9045.005049444555, 8862.734117976472, 8934.597943092544, 8935.55322233889, 8938.687145949893, 8940.910590894106, 8984.8652270216, 8997.640094396216, 9036.728898133033, 9065.501397423139, 9092.954535227314, 8941.50821704806, 8952.283817294601, 8958.283337332998, 9002.86495702565, 9005.054469280696, 8945.418547794372, 8988.77528061797, 9011.27909767217, 9030.50332231727, 9038.54807259641, 33526.49710254348, 40141.19717605661, 40232.0, 40446.0, 40461.0, 3135.1535085527007, 3306.7354611631013, 3377.206356506219, 3463.619001909788, 3546.131197856516, 30474.69525304741, 30722.078337649906, 30773.38453230923, 31017.0, 32008.199795005312, 3851.614838516154, 3874.4769456123345, 3917.216556688674, 4041.8585349512628, 4078.4290199372113, 305490.0, 306958.0, 307228.0, 307258.0, 308063.4596827024, 32033.359332813678, 32340.35319293601, 32440.188995275308, 32456.35087298288, 32516.83741581277, 32872.671273286964, 33364.3327133456, 33442.665573343955, 33576.1605959853, 34537.48193777095, 17388.65222695539, 17490.387836425663, 17591.120443978005, 17596.824031759774, 17608.735868961976, 13456.327183640975, 13575.456981720818, 13607.251601162032, 13638.590842274747, 13665.453381864614, 19224.72316854851, 19400.32098876561, 19438.70841937372, 19492.0, 19554.608907821763, 7102.5028248022145, 7185.676644550903, 7221.89167162493, 7329.486935914541, 7500.174980752113, 996.5216695985822, 1000.7097941596855, 1092.8743194532572, 1154.1171004181808, 1196.682879037056, 32731.0, 32884.0, 33001.3399732004, 33492.49761253583, 33707.157321066676, 1071.5231721883843, 1127.2729089737074, 1173.3663821536445, 1190.3810018790355, 1203.5005472728894, 17198.31206751716, 17459.912700436416, 17486.86523582993, 17537.473875783748, 18033.639327213645, 514951.0, 517272.0, 519705.0, 519750.0, 524148.0, 57914.420855791745, 57945.42054579485, 58227.70886145542, 58243.12635310474, 58492.0, 1336.672515233774, 1396.322783450026, 1404.0452492305126, 1417.893657975656, 1421.8862491000696, 31966.84016579902, 33121.33757324792, 33278.0, 33396.1650958728, 33905.15237119092, 49161.508384915694, 49811.501884982135, 50148.0, 50220.497795023046, 50461.747691261306, 468733.0, 471877.0, 475467.0, 477365.0, 478947.0, 24899.37751556153, 25113.24660260195, 25696.229113126636, 25770.35574110662, 25951.22146335613, 46600.30099548442, 46610.13559457584, 46982.76508617435, 47451.0, 47689.52310476851, 38899.0, 40484.19031619292, 40769.59230407658, 40883.18233635251, 41104.38343424791, 39547.40678889876, 40496.0, 40763.1847363057, 40841.38737918993, 41022.0, 39739.40390894197, 40275.0, 40303.0, 40366.59633403629, 40441.59558404496, 33851.83074084712, 35762.8211858939, 36246.818765906, 36277.09307267339, 36421.635783641825, 27396.58905116385, 27473.86263068672, 27524.862375687993, 27916.581251281652, 27962.440751184455], "value": 19355.791013298607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.2311883485264, 382.3137468244501, 382.6192938026664, 387.2255489021956, 397.67986770649617, 17610.82389176108, 19327.0, 19494.415167544998, 19497.902510487445, 19698.507537311576, 18156.0, 18249.543761405937, 18998.2400703972, 19132.23471061156, 19138.0, 5225.0, 5647.604667673254, 5806.216160818278, 5853.50245229156, 5856.73644685988, 5528.087865502187, 5631.267935168423, 5645.294338207724, 5646.830595082154, 5651.491365777079, 5545.473180047889, 6225.221847269091, 6412.967935160318, 6414.198225221848, 6423.775167869126, 6309.621422714606, 6325.683715814214, 6358.173437453124, 6393.840153996187, 6396.328385519523, 5526.226328314039, 5633.155026746021, 5643.0, 5660.0, 5661.716914154275, 11907.464164112636, 11982.580609678707, 22156.556868862695, 22290.219842305603, 22377.0, 2206.7572567017614, 2323.8257130715097, 2326.3718795925174, 2379.3337865397716, 2776.319801648609, 9767.609295628166, 9793.755156121082, 9936.0, 10872.0, 14399.344075431354, 1912.9330473433502, 1952.2581419060666, 1957.862949593529, 1976.505873531617, 1999.7600287965392, 76600.61699691521, 79552.0, 80403.59798200971, 80500.59749701273, 81775.0, 10340.44893266001, 10729.0, 10762.24664273509, 10875.673729788119, 10917.290376125686, 14792.334344954503, 14818.555443336718, 14890.0, 14909.70180596382, 14919.477818276308, 7729.806754831175, 8009.959950200212, 8020.679172833022, 8169.877451838227, 8240.50556966584, 7799.259070388304, 7803.102643196105, 7819.765407037798, 7887.763367098996, 7970.568976462235, 4580.4045474088825, 4597.609203217697, 4626.629869610423, 4651.651126165551, 4728.290756386569, 1925.422373288008, 1949.210569719266, 2014.1540552967788, 2015.2140665140607, 2022.7876073012417, 909.6179604565966, 1010.4240582867842, 1030.922680798943, 1042.0517329230515, 1049.1763965287214, 19455.805441945682, 19532.90233548823, 19731.60536789256, 19885.204591816455, 20012.39962801089, 934.359963425056, 940.5485367023867, 954.656323723459, 966.4732720667254, 972.3242346569067, 10562.202495818805, 11094.0, 11151.553937842395, 11179.385133817717, 11271.718207044725, 404269.0, 406636.0, 443685.0, 445039.0, 446869.0, 73569.0, 81869.59065204755, 83118.58440707758, 94953.0, 96895.51552242193, 1002.333448256901, 1014.0265345268477, 1039.4127318065268, 1061.5753698520653, 1064.6965614799744, 17582.38461653836, 17779.46661600154, 18133.546661333574, 18255.726164107284, 18619.255229790655, 33535.496967545994, 40441.98895027648, 41259.793701032504, 45464.77267613641, 45561.54438455573, 61056.389436106845, 61654.38345616486, 62511.0, 62978.68510657417, 64116.0, 8289.378296627656, 8481.15188481147, 8770.342224333328, 8805.955970220108, 8872.157145071207, 9824.901750982399, 14035.087719298213, 14147.221902795445, 14522.273886305853, 14567.635809104857, 11903.583374581847, 12126.878731212575, 12182.817257740964, 12257.754844903231, 12349.19730217533, 11371.54513819438, 11597.75018232347, 11634.0, 11925.880741192477, 12315.568955086528, 12408.689782755504, 12491.625251242478, 12537.623871283877, 12554.937225313815, 12921.935390323364, 7438.033055702724, 8337.666493340199, 8395.580220988804, 8535.231829135408, 8669.263112635497, 11584.131190160602, 11864.703382415508, 12147.088968327587, 12493.687657808265, 12536.997040236942], "value": 9216.323083798203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.6943041961188, 1458.8687018168362, 1553.3708847916591, 1650.306871114132, 1672.8494435500802, 7339.743108991173, 8171.8365632687455, 8233.547154906477, 8725.738227853166, 8729.0, 8292.626831792568, 8511.489310641366, 8533.701320453785, 8580.184882436159, 8595.699150529732, 2331.9766802332015, 2353.0470159585393, 2369.845960012594, 2370.3718514593647, 2380.5357955198742, 2300.401895507172, 2304.5275718477674, 2345.906163753448, 2382.130522359335, 2389.1160270699866, 2321.6401457774073, 2328.208409140892, 2343.3907184132077, 2346.7301260355107, 2368.2421625079983, 2276.226083131743, 2285.0859656137513, 2289.9656505152434, 2295.2655150351893, 2296.2307626944994, 2242.1367773407355, 2253.312739614417, 2253.9549209015727, 2255.819534437241, 2260.785225403584, 8575.485470871705, 8613.353998450142, 8654.09132041133, 8656.523891185981, 8672.13278672134, 5014.047331007097, 5093.159628661267, 5127.410347810012, 5129.153689641204, 5151.665141765773, 3201.295714942709, 3294.7199488043543, 3346.196912740949, 3349.346877358916, 3399.963011281558, 1059.1579694143174, 1064.6007747094839, 1071.6088627650852, 1083.1118482844072, 1086.9239153259275, 11814.704632384173, 11870.52517899283, 11873.881261187364, 11894.643160705193, 11901.226420282654, 4524.954750452519, 4549.499555048942, 4583.587477127075, 4626.421697287839, 4638.7216766993415, 9933.50332483373, 9997.900020999843, 10011.299209055442, 10014.64948726791, 10029.247806414402, 5173.379194496684, 5176.068307704574, 5181.5854731621375, 5181.870453238699, 5226.895462090737, 4059.2287465381482, 4587.9541204588195, 4694.600958918462, 4706.435227772689, 4722.0, 3808.5810560838286, 3909.4917660703927, 3937.684985201177, 3981.5023122109737, 3998.8400463981116, 1236.2458900070949, 1239.1202246404973, 1240.0637518673343, 1245.4333278358324, 1247.3077442019585, 985.3152059318704, 1003.062136901999, 1007.4005966449951, 1011.2516737614112, 1022.7698767777191, 5882.0, 5930.940690593039, 5970.223870896755, 6005.0, 6159.414855588712, 961.2262128986233, 964.6880242869692, 965.8744363232735, 989.312427862643, 1014.852846337277, 4085.836566537365, 4291.356296555479, 4339.848105316299, 4349.13017396522, 4387.407699960529, 9883.555240014217, 10011.949940250252, 10145.492725363702, 10158.542865571068, 10183.949080254552, 10079.64721234768, 10090.99090090985, 10102.69691909244, 10112.949435252776, 10153.441560714084, 7493.325600695964, 7830.608469576612, 7971.960140199378, 8121.390895682847, 8132.674693012332, 5956.5462613113705, 6068.21113255274, 6127.785527506694, 6204.7828326008375, 6283.3716628338625, 9858.654947076819, 9863.210943124677, 9930.751731206778, 9931.900680993098, 9964.302498825013, 9708.85436718464, 9817.55820988043, 10054.597816087275, 10113.797724045626, 10158.187345012233, 6677.866442671022, 7219.169795473587, 7485.47601667878, 7514.098308203051, 7652.120006199359, 8136.0643525995265, 8143.104258531675, 8208.712695055645, 8209.0, 8217.219364160395, 7152.0, 7426.665800039119, 7533.284337987882, 7538.0, 7647.464677472523, 7335.77992660221, 7412.258774122544, 7445.367143792838, 7454.92545074564, 7569.243075692387, 6943.618101004493, 6964.686589103604, 6965.303469652994, 6989.266127056586, 6998.370146686822, 4963.429205641398, 5026.798928042837, 5127.0, 5299.417064122867, 5359.544438722753, 5278.287431196739, 5305.495977882095, 5391.541718953933, 5522.641028333145, 5589.720513974204], "value": 4570.722577380604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2614855090536, 322.1366737144453, 324.6866425309622, 327.4891169775151, 331.78102452381404, 5561.360443548993, 5657.236273103135, 5705.229793977806, 5728.25532680752, 5730.283714535683, 5539.362973258077, 5577.498025177733, 5580.386157522669, 5581.665100093997, 5587.357453892803, 4307.3969644249755, 4317.373980772786, 4342.392065110887, 4352.194843953878, 4354.95481084539, 4275.914481710364, 4298.376735373369, 4305.720128191673, 4343.109662519192, 4357.782110894458, 4229.598188172119, 4235.597618226264, 4239.491261048678, 4260.808263628144, 4293.613574778269, 4290.334998075287, 4303.35449682547, 4303.720258183223, 4308.719933204332, 4322.157179349996, 3630.981845090784, 3736.8229007862437, 3750.706006427778, 3761.153740408414, 3766.133789228493, 5458.754356053987, 5484.177373393983, 5503.807366742145, 5509.889802203974, 5517.310336207974, 4880.6095512358925, 4885.2427873679635, 4889.779959901813, 4890.951090489085, 4959.950400495985, 5683.277453268116, 5845.883082338372, 5881.823725221695, 5882.735276912549, 5886.352501224862, 4103.6252855293515, 4107.753534787892, 4114.0, 4115.156392939441, 4126.277901367249, 5781.19063331134, 6005.309389420229, 6101.047664747282, 6163.476104531121, 6166.321704612489, 4099.221147981874, 4137.97931010349, 4143.129942712004, 4163.854265100767, 4178.101708132705, 4229.619334259932, 4239.109786944715, 4246.299360605527, 4246.341817018305, 4280.229558679405, 4667.789949452283, 4950.480199578992, 4952.851414457572, 4958.355413796184, 4962.255661650709, 5959.791407300723, 5966.910496342558, 5977.880442391215, 5983.820485385445, 6018.277806663141, 1452.9128252304895, 1468.8898332625097, 1477.0546850015999, 1487.375302373006, 1488.8312674550643, 900.7029876977132, 919.6229545886289, 928.9489078100634, 937.5593471068587, 948.672707915768, 5013.197888337849, 5038.521340472649, 5041.344625198701, 5076.806950366661, 5081.119985605275, 5352.584118102581, 5356.384015838151, 5375.0, 5450.400455949843, 5453.364640055921, 4907.411110666671, 5122.201805860181, 5171.50870667286, 5183.585313174937, 5202.167653175549, 2961.304093538017, 2969.5248760198697, 2971.85140742962, 2974.824944147093, 2985.9399913030998, 5619.325680918316, 5632.605717599728, 5664.716764161775, 5696.857578560486, 5705.31850030485, 5337.8131765388025, 5398.379186393537, 5543.473370029841, 5546.722663866791, 5583.720813959286, 5434.956424402348, 5500.642458240201, 5515.227868098469, 5562.276904002454, 5587.563648356313, 5276.70978096193, 5362.785488580413, 5474.39781624029, 5477.75350109238, 5507.375324279267, 5365.865853353697, 5389.622726409114, 5441.945580544144, 5458.6724796512335, 5462.661647896291, 6060.909086363797, 6139.785107521216, 6189.288231853395, 6246.593971391845, 6283.874322513433, 4165.396017577495, 4181.330987042059, 4181.853635122756, 4189.350650649154, 4192.119654872511, 5908.793192238423, 6079.209702738615, 6089.5737298388685, 6101.054336577838, 6114.327423983447, 5876.647401155773, 5917.556183286357, 5938.940610593839, 5946.970265148647, 5967.373425790403, 5803.187553742564, 5886.764529418775, 5920.230370051866, 5963.70181490915, 6008.369121242382, 5708.686022268815, 5823.388544202798, 5896.145058966512, 5931.703414829155, 5942.702864856654, 5947.940520594739, 5957.642541447527, 5974.701264936649, 6016.2780466342565, 6032.547558933185, 5677.630953987978, 5816.389279125631, 5817.825465236049, 5819.79630712923, 5855.677937713296], "value": 4333.777683003692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.1056111543915, 753.5817621220223, 767.202109805802, 791.1692722641226, 803.4857691077708, 14814.407423703038, 14857.182854942974, 15327.616809579738, 15757.527274181779, 15781.84218157818, 14801.11193328401, 15040.247987600631, 15045.548633541011, 15176.544703658881, 15191.924040379783, 787.9330256928168, 795.892554505143, 798.636620337745, 799.7161007842219, 801.2748462641318, 786.9213078692113, 797.3541431440523, 818.6684392820918, 821.3880658909121, 823.8558252305852, 845.3786466946789, 847.3644766425181, 848.9066202717696, 851.693390379466, 852.8081181734091, 839.4040231435657, 842.0148426341195, 843.0347252396003, 844.6705784743955, 847.1486156412766, 614.8493619063358, 615.7198474694003, 616.4020899727258, 619.4239357397619, 620.950323974081, 15567.37730490779, 15654.45209417665, 15671.294791734284, 15794.684106317809, 15809.051456912623, 14435.13389196641, 14444.57754352337, 14526.927365363106, 14643.487477938328, 14679.77980330296, 12242.693932651666, 12250.326232057234, 12342.691432714253, 12493.437795299233, 12547.372631368395, 3900.551436584772, 3947.072437977073, 3968.7817170055637, 4046.59534046593, 4068.7151899367054, 80076.59961700212, 80649.19350806533, 80996.0, 80996.19003810005, 81452.59273703594, 11016.834747478793, 11230.438478076063, 11466.31202127875, 11810.763784724257, 12131.96523442779, 21645.567088658452, 22573.0, 22890.885545572164, 22950.0, 23001.079956801874, 8873.0, 8899.599518021705, 8909.331800114887, 8990.0, 9158.129977652112, 4879.634027447884, 4882.998985208023, 4919.4834542373255, 4977.601791856715, 5038.773255203525, 3497.527833742412, 3587.4260118380935, 3652.2695460907926, 3664.486971823947, 3929.44987701722, 720.621673621353, 734.0164179998827, 742.0501757750088, 747.2975403121048, 764.0602059466776, 626.2328647406981, 704.3977399323607, 705.3968856627612, 709.9964500177466, 721.9314165154302, 10012.799744005224, 10026.398416095057, 10349.275550711378, 10519.00069493397, 10737.463126843626, 679.2935347238816, 685.9897101543481, 689.8620275944832, 733.8275505256261, 776.343989329016, 4839.225723884161, 4850.854474365775, 5002.399712034579, 5015.172496538104, 5134.845954621367, 104797.0, 106237.46881265544, 106699.46650266854, 107519.46240268748, 110088.0, 88137.55931220303, 92103.53948230216, 92945.5352723232, 96691.0, 99439.0, 85552.57223713966, 86100.13899861046, 86873.1312686865, 88645.0, 88932.11067889238, 9484.95257523708, 9507.952460237655, 9547.188488978236, 9637.951810240904, 9714.0, 50059.0, 50060.49939500704, 51149.488505114474, 52726.20910686266, 53327.466725333805, 66681.33318666945, 75277.24722752921, 75286.62356688401, 75703.24296756962, 75922.0, 12042.277463352228, 12141.878581214074, 12403.13178077562, 12417.19288246261, 12962.22226666403, 13959.860401395856, 14029.368678409292, 14321.28393580296, 14392.28038598045, 14603.415863365346, 12885.226886386847, 13144.145630533985, 13306.0, 13592.11651242666, 13656.522021729192, 12902.969194359877, 13115.27865967381, 13401.195928244337, 13652.658683532594, 13811.585652430444, 11459.541618335506, 12323.938380308042, 12566.37168141571, 13583.79624305656, 14148.646283842987, 11846.407679616157, 12037.939810300892, 12238.204516706386, 12408.56570020045, 12491.812622810847, 11753.412329383667, 12065.81901271464, 12107.152499324962, 12203.877961220274, 12292.261766264026], "value": 7667.250442855486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 105.0, 110.0, 111.0, 111.0, 117.0, 113.0, 111.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 139.0, 157.0, 182.0, 137.0, 162.0, 169.0, 137.0, 192.0, 129.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 163.0, 169.0, 170.0, 162.0, 163.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 153.0, 76.0, 76.0, 76.0, 75.0, 166.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 144.0, 85.0, 85.0, 85.0, 150.0, 85.0, 86.0, 158.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 149.0, 148.0, 152.0, 147.0, 147.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 62.0, 64.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 82.0, 80.0, 87.0, 82.0, 81.0, 86.0, 147.0, 80.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 125.0, 126.0, 124.0, 130.0, 133.0, 128.0, 129.0, 124.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 177.0, 166.0, 162.0, 161.0, 171.0, 163.0, 164.0, 161.0, 169.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 65.0, 68.0, 68.0, 64.0, 66.0, 63.0, 63.0], "value": 65.8, "unit": "score"}]}]} 19:56:37 INFO - Return code: 0 19:56:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:56:37 ERROR - # TBPL SUCCESS # 19:56:37 INFO - Running post-action listener: _resource_record_post_action 19:56:37 INFO - ##### 19:56:37 INFO - ##### Finished run-tests step (success) 19:56:37 INFO - ##### 19:56:37 INFO - Running post-run listener: _resource_record_post_run 19:56:38 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 4096; Write bytes: 552648704; Read time: 12; Write time: 579052 19:56:38 INFO - TinderboxPrint: CPU usage
13.6% 19:56:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:56:38 INFO - TinderboxPrint: I/O write bytes / time
552,648,704 / 579,052 19:56:38 INFO - TinderboxPrint: CPU idle
8,233.3 (86.4%) 19:56:38 INFO - TinderboxPrint: CPU user
1,234.6 (13.0%) 19:56:38 INFO - TinderboxPrint: Swap in / out
0 / 0 19:56:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263483392; Read time: 0; Write time: 356436 19:56:38 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 4096; Write bytes: 289165312; Read time: 12; Write time: 222616 19:56:38 INFO - Running post-run listener: _upload_blobber_files 19:56:38 INFO - Blob upload gear active. 19:56:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:38 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 19:56:38 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:56:38 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:56:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:42 INFO - (blobuploader) - INFO - Done attempting. 19:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:43 INFO - (blobuploader) - INFO - Done attempting. 19:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:43 INFO - (blobuploader) - INFO - Done attempting. 19:56:43 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:43 INFO - Return code: 0 19:56:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee67a01b3ee2cafceab7e97e1c93338903b32d18adbb25e9f18fbd74fa7208c3eff8f7906e05c73a02c7e7651c9474f0d08a1fdc519f620e33cb4c3e24abe496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcef5f8e54eb528727bb69f1aab6d0b16741b6825780f4a628a808daf35e38b736f38448343e4869998419344b009ea70f3992361cb67381b388d196221e2815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04b121364c6ff4711c292b23811f83b5a46bb473f14d2254278d649284d64777e21df3ac6409c8d23befccbb96f8b5fa5e29f5d493ec3bae1041b9705c4c0dc5"} 19:56:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:43 INFO - Contents: 19:56:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee67a01b3ee2cafceab7e97e1c93338903b32d18adbb25e9f18fbd74fa7208c3eff8f7906e05c73a02c7e7651c9474f0d08a1fdc519f620e33cb4c3e24abe496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcef5f8e54eb528727bb69f1aab6d0b16741b6825780f4a628a808daf35e38b736f38448343e4869998419344b009ea70f3992361cb67381b388d196221e2815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04b121364c6ff4711c292b23811f83b5a46bb473f14d2254278d649284d64777e21df3ac6409c8d23befccbb96f8b5fa5e29f5d493ec3bae1041b9705c4c0dc5"} 19:56:43 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:43 INFO - Copying logs to upload dir... 19:56:43 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.458409 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-27 19:56:43.699104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:56:43.702767) ========= 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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 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-Inbound/sha512/ee67a01b3ee2cafceab7e97e1c93338903b32d18adbb25e9f18fbd74fa7208c3eff8f7906e05c73a02c7e7651c9474f0d08a1fdc519f620e33cb4c3e24abe496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcef5f8e54eb528727bb69f1aab6d0b16741b6825780f4a628a808daf35e38b736f38448343e4869998419344b009ea70f3992361cb67381b388d196221e2815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04b121364c6ff4711c292b23811f83b5a46bb473f14d2254278d649284d64777e21df3ac6409c8d23befccbb96f8b5fa5e29f5d493ec3bae1041b9705c4c0dc5"} build_url:https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011510 build_url: 'https://queue.taskcluster.net/v1/task/AZkEtCHBSaeEwTks5CDhZg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee67a01b3ee2cafceab7e97e1c93338903b32d18adbb25e9f18fbd74fa7208c3eff8f7906e05c73a02c7e7651c9474f0d08a1fdc519f620e33cb4c3e24abe496", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bcef5f8e54eb528727bb69f1aab6d0b16741b6825780f4a628a808daf35e38b736f38448343e4869998419344b009ea70f3992361cb67381b388d196221e2815", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04b121364c6ff4711c292b23811f83b5a46bb473f14d2254278d649284d64777e21df3ac6409c8d23befccbb96f8b5fa5e29f5d493ec3bae1041b9705c4c0dc5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 19:56:43.729093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:56:43.730155) ========= 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=eca2ab57546de7b41f256b19000001ef-1467081367.415324-589774621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 19:56:43.811097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:56:43.811435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 19:56:43.811751) ========= ========= Total master_lag: 0.16 =========