builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1466705739.75 results: success (0) buildid: 20160623083101 builduid: 95fec6d82f064764affe3f1953256a50 revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.750262) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.750997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.751301) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.767828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.768482) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 11:15:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-06-23 11:15:40 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074528 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.857594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.857897) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015569 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.908083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:39.908438) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 11:15:40,114 truncating revision to first 12 chars 2016-06-23 11:15:40,114 Setting DEBUG logging. 2016-06-23 11:15:40,114 attempt 1/10 2016-06-23 11:15:40,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7e793ef71a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 11:15:40,414 unpacking tar archive at: fx-team-a7e793ef71a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649936 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.573413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.573741) ========= script_repo_revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.574181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.574631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 11:15:40.585443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-23 11:15:40.585774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:40 INFO - MultiFileLogger online at 20160623 11:15:40 in /builds/slave/test 11:15:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:15:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:40 INFO - {'append_to_log': False, 11:15:40 INFO - 'base_work_dir': '/builds/slave/test', 11:15:40 INFO - 'blob_upload_branch': 'Fx-Team', 11:15:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:40 INFO - 'branch': 'Fx-Team', 11:15:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:40 INFO - 'config_files': ('talos/linux_config.py',), 11:15:40 INFO - 'default_actions': ('clobber', 11:15:40 INFO - 'read-buildbot-config', 11:15:40 INFO - 'download-and-extract', 11:15:40 INFO - 'populate-webroot', 11:15:40 INFO - 'create-virtualenv', 11:15:40 INFO - 'install', 11:15:40 INFO - 'run-tests'), 11:15:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:40 INFO - 'download_minidump_stackwalk': True, 11:15:40 INFO - 'download_symbols': 'ondemand', 11:15:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:15:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:15:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:15:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:15:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:40 INFO - 'installer_path': 'installer.exe', 11:15:40 INFO - 'log_level': 'info', 11:15:40 INFO - 'log_name': 'talos', 11:15:40 INFO - 'log_to_console': True, 11:15:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:40 INFO - 'opt_config_files': (), 11:15:40 INFO - 'pip_index': False, 11:15:40 INFO - 'sps_profile': False, 11:15:40 INFO - 'sps_profile_interval': 0, 11:15:40 INFO - 'suite': 'dromaeojs-e10s', 11:15:40 INFO - 'system_bits': '32', 11:15:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:40 INFO - 'title': 'talos-linux64-ix-046', 11:15:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:40 INFO - 'use_talos_json': True, 11:15:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:40 INFO - 'work_dir': 'build'} 11:15:40 INFO - ##### 11:15:40 INFO - ##### Running clobber step. 11:15:40 INFO - ##### 11:15:40 INFO - Running pre-action listener: _resource_record_pre_action 11:15:40 INFO - Running main action method: clobber 11:15:40 INFO - rmtree: /builds/slave/test/build 11:15:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:41 INFO - Running post-action listener: _resource_record_post_action 11:15:41 INFO - ##### 11:15:41 INFO - ##### Finished clobber step (success) 11:15:41 INFO - ##### 11:15:41 INFO - ##### 11:15:41 INFO - ##### Running read-buildbot-config step. 11:15:41 INFO - ##### 11:15:41 INFO - Running pre-action listener: _resource_record_pre_action 11:15:41 INFO - Running main action method: read_buildbot_config 11:15:41 INFO - Using buildbot properties: 11:15:41 INFO - { 11:15:41 INFO - "project": "", 11:15:41 INFO - "product": "firefox", 11:15:41 INFO - "script_repo_revision": "production", 11:15:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:15:41 INFO - "repository": "", 11:15:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:15:41 INFO - "buildid": "20160623083101", 11:15:41 INFO - "pgo_build": "True", 11:15:41 INFO - "basedir": "/builds/slave/test", 11:15:41 INFO - "buildnumber": 861, 11:15:41 INFO - "slavename": "talos-linux64-ix-046", 11:15:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:15:41 INFO - "platform": "ubuntu64_hw", 11:15:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:15:41 INFO - "branch": "fx-team", 11:15:41 INFO - "repo_path": "integration/fx-team", 11:15:41 INFO - "revision": "a7e793ef71a31643eddd1bf7cb7a80b580cb8284", 11:15:41 INFO - "stage_platform": "linux64-pgo", 11:15:41 INFO - "builduid": "95fec6d82f064764affe3f1953256a50", 11:15:41 INFO - "slavebuilddir": "test" 11:15:41 INFO - } 11:15:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:15:41 INFO - Running post-action listener: _resource_record_post_action 11:15:41 INFO - ##### 11:15:41 INFO - ##### Finished read-buildbot-config step (success) 11:15:41 INFO - ##### 11:15:41 INFO - ##### 11:15:41 INFO - ##### Running download-and-extract step. 11:15:41 INFO - ##### 11:15:41 INFO - Running pre-action listener: _resource_record_pre_action 11:15:41 INFO - Running main action method: download_and_extract 11:15:41 INFO - mkdir: /builds/slave/test/build/tests 11:15:41 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')]} 11:15:41 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:51 INFO - Downloaded 1361 bytes. 11:15:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:15:51 INFO - Using the following test package requirements: 11:15:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:15:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:15:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:15:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'jsshell-linux-x86_64.zip'], 11:15:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:15:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:15:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:15:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:15:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:15:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:15:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:15:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:15:51 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')]} 11:15:51 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:15:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:56 INFO - Downloaded 24275576 bytes. 11:15:56 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'] 11:15:56 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 11:15:57 INFO - Return code: 0 11:15:57 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 11:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:57 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:16:00 INFO - Downloaded 24275576 bytes. 11:16:00 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'] 11:16:00 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 11:16:02 INFO - Return code: 0 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:02 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:16:03 INFO - Downloaded 14405384 bytes. 11:16:03 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'] 11:16:03 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 11:16:03 INFO - Return code: 0 11:16:03 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')]} 11:16:03 INFO - https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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 11:16:05 INFO - Downloaded 60162197 bytes. 11:16:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:05 INFO - mkdir: /builds/slave/test/properties 11:16:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:05 INFO - Contents: 11:16:05 INFO - build_url:https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:16:05 INFO - Running post-action listener: _resource_record_post_action 11:16:05 INFO - Running post-action listener: set_extra_try_arguments 11:16:05 INFO - ##### 11:16:05 INFO - ##### Finished download-and-extract step (success) 11:16:05 INFO - ##### 11:16:05 INFO - ##### 11:16:05 INFO - ##### Running populate-webroot step. 11:16:05 INFO - ##### 11:16:05 INFO - Running pre-action listener: _resource_record_pre_action 11:16:05 INFO - Running main action method: populate_webroot 11:16:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:05 INFO - '--tppagecycles', 11:16:05 INFO - '7'], 11:16:05 INFO - 'tests': ['tsvgm']}}, 11:16:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:16:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['damp', 'tps']}, 11:16:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'tests': ['damp', 'tps']}, 11:16:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['dromaeo_dom']}, 11:16:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['basic_compositor_video']}, 11:16:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:16:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['a11yr', 11:16:05 INFO - 'ts_paint', 11:16:05 INFO - 'tpaint', 11:16:05 INFO - 'sessionrestore', 11:16:05 INFO - 'sessionrestore_no_auto_restore', 11:16:05 INFO - 'tabpaint']}, 11:16:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['tsvgx', 11:16:05 INFO - 'tsvgr_opacity', 11:16:05 INFO - 'tart', 11:16:05 INFO - 'tscrollx', 11:16:05 INFO - 'cart']}, 11:16:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:05 INFO - 'tsvgr_opacity', 11:16:05 INFO - 'tart', 11:16:05 INFO - 'tscrollx', 11:16:05 INFO - 'cart']}, 11:16:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'talos_options': ['--disable-e10s'], 11:16:05 INFO - 'tests': ['tp5o']}, 11:16:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'tests': ['tp5o']}, 11:16:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'talos_options': ['--disable-e10s', 11:16:05 INFO - '--xperf_path', 11:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:05 INFO - 'tests': ['tp5n']}, 11:16:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:05 INFO - 'talos_options': ['--xperf_path', 11:16:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:05 INFO - 'tests': ['tp5n']}}, 11:16:05 INFO - 'talos.zip': {'path': '', 11:16:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:05 INFO - Running post-action listener: _resource_record_post_action 11:16:05 INFO - ##### 11:16:05 INFO - ##### Finished populate-webroot step (success) 11:16:05 INFO - ##### 11:16:05 INFO - ##### 11:16:05 INFO - ##### Running create-virtualenv step. 11:16:05 INFO - ##### 11:16:05 INFO - Running pre-action listener: _resource_record_pre_action 11:16:05 INFO - Running main action method: create_virtualenv 11:16:05 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:05 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 11:16:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:06 INFO - Using real prefix '/usr' 11:16:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:08 INFO - Installing pip.................done. 11:16:08 INFO - Return code: 0 11:16:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:08 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 11:16:08 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 11:16:08 INFO - Using env: {'DISPLAY': ':0', 11:16:08 INFO - 'HOME': '/home/cltbld', 11:16:08 INFO - 'LANG': 'en_US.UTF-8', 11:16:08 INFO - 'LANGUAGE': 'en_US:en', 11:16:08 INFO - 'LOGNAME': 'cltbld', 11:16:08 INFO - 'MAIL': '/var/mail/cltbld', 11:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:08 INFO - 'MOZ_NO_REMOTE': '1', 11:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:08 INFO - 'NO_EM_RESTART': '1', 11:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:08 INFO - 'PWD': '/builds/slave/test', 11:16:08 INFO - 'SHELL': '/bin/bash', 11:16:08 INFO - 'SHLVL': '1', 11:16:08 INFO - 'TERM': 'linux', 11:16:08 INFO - 'TMOUT': '86400', 11:16:08 INFO - 'USER': 'cltbld', 11:16:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:08 INFO - '_': '/tools/buildbot/bin/python'} 11:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:08 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 11:16:08 INFO - Cleaning up... 11:16:08 INFO - Return code: 0 11:16:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:08 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:08 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 11:16:08 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 11:16:08 INFO - Using env: {'DISPLAY': ':0', 11:16:08 INFO - 'HOME': '/home/cltbld', 11:16:08 INFO - 'LANG': 'en_US.UTF-8', 11:16:08 INFO - 'LANGUAGE': 'en_US:en', 11:16:08 INFO - 'LOGNAME': 'cltbld', 11:16:08 INFO - 'MAIL': '/var/mail/cltbld', 11:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:08 INFO - 'MOZ_NO_REMOTE': '1', 11:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:08 INFO - 'NO_EM_RESTART': '1', 11:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:08 INFO - 'PWD': '/builds/slave/test', 11:16:08 INFO - 'SHELL': '/bin/bash', 11:16:08 INFO - 'SHLVL': '1', 11:16:08 INFO - 'TERM': 'linux', 11:16:08 INFO - 'TMOUT': '86400', 11:16:08 INFO - 'USER': 'cltbld', 11:16:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:08 INFO - '_': '/tools/buildbot/bin/python'} 11:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:08 INFO - Downloading/unpacking psutil>=3.1.1 11:16:08 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 11:16:08 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 11:16:08 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 11:16:08 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 11:16:08 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 11:16:08 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 11:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:10 INFO - Installing collected packages: psutil 11:16:10 INFO - Running setup.py install for psutil 11:16:11 INFO - building 'psutil._psutil_linux' extension 11:16:11 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 11:16:11 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 11:16:11 INFO - building 'psutil._psutil_posix' extension 11:16:11 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 11:16:11 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 11:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:11 INFO - Successfully installed psutil 11:16:11 INFO - Cleaning up... 11:16:11 INFO - Return code: 0 11:16:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16:11 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')]} 11:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:11 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')]} 11:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:11 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:11 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 11:16:11 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 11:16:11 INFO - Using env: {'DISPLAY': ':0', 11:16:11 INFO - 'HOME': '/home/cltbld', 11:16:11 INFO - 'LANG': 'en_US.UTF-8', 11:16:11 INFO - 'LANGUAGE': 'en_US:en', 11:16:11 INFO - 'LOGNAME': 'cltbld', 11:16:11 INFO - 'MAIL': '/var/mail/cltbld', 11:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:11 INFO - 'MOZ_NO_REMOTE': '1', 11:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:11 INFO - 'NO_EM_RESTART': '1', 11:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:11 INFO - 'PWD': '/builds/slave/test', 11:16:11 INFO - 'SHELL': '/bin/bash', 11:16:11 INFO - 'SHLVL': '1', 11:16:11 INFO - 'TERM': 'linux', 11:16:11 INFO - 'TMOUT': '86400', 11:16:11 INFO - 'USER': 'cltbld', 11:16:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:11 INFO - '_': '/tools/buildbot/bin/python'} 11:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:13 INFO - Installing collected packages: mozsystemmonitor 11:16:13 INFO - Running setup.py install for mozsystemmonitor 11:16:13 INFO - Successfully installed mozsystemmonitor 11:16:13 INFO - Cleaning up... 11:16:13 INFO - Return code: 0 11:16:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:13 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:13 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 11:16:13 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 11:16:13 INFO - Using env: {'DISPLAY': ':0', 11:16:13 INFO - 'HOME': '/home/cltbld', 11:16:13 INFO - 'LANG': 'en_US.UTF-8', 11:16:13 INFO - 'LANGUAGE': 'en_US:en', 11:16:13 INFO - 'LOGNAME': 'cltbld', 11:16:13 INFO - 'MAIL': '/var/mail/cltbld', 11:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:13 INFO - 'MOZ_NO_REMOTE': '1', 11:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:13 INFO - 'NO_EM_RESTART': '1', 11:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:13 INFO - 'PWD': '/builds/slave/test', 11:16:13 INFO - 'SHELL': '/bin/bash', 11:16:13 INFO - 'SHLVL': '1', 11:16:13 INFO - 'TERM': 'linux', 11:16:13 INFO - 'TMOUT': '86400', 11:16:13 INFO - 'USER': 'cltbld', 11:16:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:13 INFO - '_': '/tools/buildbot/bin/python'} 11:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:16 INFO - warning: no files found matching '*.txt' 11:16:16 INFO - no previously-included directories found matching 'build' 11:16:16 INFO - no previously-included directories found matching 'dist' 11:16:16 INFO - no previously-included directories found matching '.git*' 11:16:16 INFO - Installing collected packages: jsonschema, functools32 11:16:16 INFO - Running setup.py install for functools32 11:16:16 INFO - warning: no files found matching '*.txt' 11:16:16 INFO - no previously-included directories found matching 'build' 11:16:16 INFO - no previously-included directories found matching 'dist' 11:16:16 INFO - no previously-included directories found matching '.git*' 11:16:16 INFO - Successfully installed jsonschema functools32 11:16:16 INFO - Cleaning up... 11:16:16 INFO - Return code: 0 11:16:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:16 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:16 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 11:16:16 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 11:16:16 INFO - Using env: {'DISPLAY': ':0', 11:16:16 INFO - 'HOME': '/home/cltbld', 11:16:16 INFO - 'LANG': 'en_US.UTF-8', 11:16:16 INFO - 'LANGUAGE': 'en_US:en', 11:16:16 INFO - 'LOGNAME': 'cltbld', 11:16:16 INFO - 'MAIL': '/var/mail/cltbld', 11:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:16 INFO - 'MOZ_NO_REMOTE': '1', 11:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:16 INFO - 'NO_EM_RESTART': '1', 11:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:16 INFO - 'PWD': '/builds/slave/test', 11:16:16 INFO - 'SHELL': '/bin/bash', 11:16:16 INFO - 'SHLVL': '1', 11:16:16 INFO - 'TERM': 'linux', 11:16:16 INFO - 'TMOUT': '86400', 11:16:16 INFO - 'USER': 'cltbld', 11:16:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:16 INFO - '_': '/tools/buildbot/bin/python'} 11:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:16 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 11:16:18 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:18 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 11:16:19 INFO - Downloading docopt-0.6.1.tar.gz 11:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:19 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:19 INFO - Running setup.py install for blobuploader 11:16:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:19 INFO - Running setup.py install for requests 11:16:19 INFO - Running setup.py install for docopt 11:16:19 INFO - Successfully installed blobuploader requests docopt 11:16:19 INFO - Cleaning up... 11:16:19 INFO - Return code: 0 11:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:19 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')]} 11:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:19 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')]} 11:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:19 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:19 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 11:16:19 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 11:16:19 INFO - Using env: {'DISPLAY': ':0', 11:16:19 INFO - 'HOME': '/home/cltbld', 11:16:19 INFO - 'LANG': 'en_US.UTF-8', 11:16:19 INFO - 'LANGUAGE': 'en_US:en', 11:16:19 INFO - 'LOGNAME': 'cltbld', 11:16:19 INFO - 'MAIL': '/var/mail/cltbld', 11:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:19 INFO - 'MOZ_NO_REMOTE': '1', 11:16:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:19 INFO - 'NO_EM_RESTART': '1', 11:16:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:19 INFO - 'PWD': '/builds/slave/test', 11:16:19 INFO - 'SHELL': '/bin/bash', 11:16:19 INFO - 'SHLVL': '1', 11:16:19 INFO - 'TERM': 'linux', 11:16:19 INFO - 'TMOUT': '86400', 11:16:19 INFO - 'USER': 'cltbld', 11:16:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:19 INFO - '_': '/tools/buildbot/bin/python'} 11:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:20 INFO - Running setup.py (path:/tmp/pip-DFneMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:20 INFO - Running setup.py (path:/tmp/pip-ICcm_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:20 INFO - Running setup.py (path:/tmp/pip-kFg7T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:20 INFO - Running setup.py (path:/tmp/pip-l2Mb8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:20 INFO - Running setup.py (path:/tmp/pip-s0et1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:20 INFO - Running setup.py (path:/tmp/pip-D673L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:20 INFO - Running setup.py (path:/tmp/pip-uKPFos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:20 INFO - Running setup.py (path:/tmp/pip-5s54QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:20 INFO - Running setup.py (path:/tmp/pip-IkfUmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:20 INFO - Running setup.py (path:/tmp/pip-7bDgTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:20 INFO - Running setup.py (path:/tmp/pip-F9fCs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:20 INFO - Running setup.py (path:/tmp/pip-aXsIQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:20 INFO - Running setup.py (path:/tmp/pip-_YbmK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:21 INFO - Running setup.py (path:/tmp/pip-MLExwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:21 INFO - Running setup.py (path:/tmp/pip-VhMq85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:21 INFO - Running setup.py (path:/tmp/pip-LNem7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:21 INFO - Running setup.py (path:/tmp/pip-O57SI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:21 INFO - Running setup.py install for manifestparser 11:16:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:21 INFO - Running setup.py install for mozcrash 11:16:21 INFO - Running setup.py install for mozdebug 11:16:21 INFO - Running setup.py install for mozdevice 11:16:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:21 INFO - Running setup.py install for mozfile 11:16:21 INFO - Running setup.py install for mozhttpd 11:16:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:21 INFO - Running setup.py install for mozinfo 11:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozInstall 11:16:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozleak 11:16:22 INFO - Running setup.py install for mozlog 11:16:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for moznetwork 11:16:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozprocess 11:16:22 INFO - Running setup.py install for mozprofile 11:16:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozrunner 11:16:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:22 INFO - Running setup.py install for mozscreenshot 11:16:22 INFO - Running setup.py install for moztest 11:16:22 INFO - Running setup.py install for mozversion 11:16:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:23 INFO - Cleaning up... 11:16:23 INFO - Return code: 0 11:16:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:23 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:23 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 11:16:23 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 11:16:23 INFO - Using env: {'DISPLAY': ':0', 11:16:23 INFO - 'HOME': '/home/cltbld', 11:16:23 INFO - 'LANG': 'en_US.UTF-8', 11:16:23 INFO - 'LANGUAGE': 'en_US:en', 11:16:23 INFO - 'LOGNAME': 'cltbld', 11:16:23 INFO - 'MAIL': '/var/mail/cltbld', 11:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:23 INFO - 'MOZ_NO_REMOTE': '1', 11:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:23 INFO - 'NO_EM_RESTART': '1', 11:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:23 INFO - 'PWD': '/builds/slave/test', 11:16:23 INFO - 'SHELL': '/bin/bash', 11:16:23 INFO - 'SHLVL': '1', 11:16:23 INFO - 'TERM': 'linux', 11:16:23 INFO - 'TMOUT': '86400', 11:16:23 INFO - 'USER': 'cltbld', 11:16:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:23 INFO - '_': '/tools/buildbot/bin/python'} 11:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:23 INFO - Running setup.py (path:/tmp/pip-1vpeGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:23 INFO - Running setup.py (path:/tmp/pip-MdTgn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:23 INFO - Running setup.py (path:/tmp/pip-REwo1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:23 INFO - Running setup.py (path:/tmp/pip-LBg8i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:23 INFO - Running setup.py (path:/tmp/pip-u61zvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:23 INFO - Running setup.py (path:/tmp/pip-TRrGXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:23 INFO - Running setup.py (path:/tmp/pip-IrOepI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:23 INFO - Running setup.py (path:/tmp/pip-MmbZgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:23 INFO - Running setup.py (path:/tmp/pip-1XzOf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:23 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)) 11:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:23 INFO - Running setup.py (path:/tmp/pip-khjUcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:24 INFO - Running setup.py (path:/tmp/pip-iC7Z4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:24 INFO - Running setup.py (path:/tmp/pip-4m25wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:24 INFO - Running setup.py (path:/tmp/pip-dPDEtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:24 INFO - Running setup.py (path:/tmp/pip-xn9Ege-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:24 INFO - Running setup.py (path:/tmp/pip-hsmnj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:24 INFO - Running setup.py (path:/tmp/pip-ggvzGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:24 INFO - Running setup.py (path:/tmp/pip-Qi67vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:24 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)) 11:16:24 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)) 11:16:24 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)) 11:16:24 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)) 11:16:24 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)) 11:16:24 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)) 11:16:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:26 INFO - Downloading blessings-1.6.tar.gz 11:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:26 INFO - Installing collected packages: blessings 11:16:26 INFO - Running setup.py install for blessings 11:16:26 INFO - Successfully installed blessings 11:16:26 INFO - Cleaning up... 11:16:26 INFO - Return code: 0 11:16:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:26 INFO - Reading from file tmpfile_stdout 11:16:26 INFO - Current package versions: 11:16:26 INFO - argparse == 1.2.1 11:16:26 INFO - blessings == 1.6 11:16:26 INFO - blobuploader == 1.2.4 11:16:26 INFO - docopt == 0.6.1 11:16:26 INFO - functools32 == 3.2.3-2 11:16:26 INFO - jsonschema == 2.5.1 11:16:26 INFO - manifestparser == 1.1 11:16:26 INFO - mozInstall == 1.12 11:16:26 INFO - mozcrash == 0.17 11:16:26 INFO - mozdebug == 0.1 11:16:26 INFO - mozdevice == 0.48 11:16:26 INFO - mozfile == 1.2 11:16:26 INFO - mozhttpd == 0.7 11:16:26 INFO - mozinfo == 0.9 11:16:26 INFO - mozleak == 0.1 11:16:26 INFO - mozlog == 3.2 11:16:26 INFO - moznetwork == 0.27 11:16:26 INFO - mozprocess == 0.22 11:16:26 INFO - mozprofile == 0.28 11:16:26 INFO - mozrunner == 6.11 11:16:26 INFO - mozscreenshot == 0.1 11:16:26 INFO - mozsystemmonitor == 0.3 11:16:26 INFO - moztest == 0.7 11:16:26 INFO - mozversion == 1.4 11:16:26 INFO - psutil == 3.1.1 11:16:26 INFO - requests == 1.2.3 11:16:26 INFO - wsgiref == 0.1.2 11:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:26 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:26 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 11:16:26 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 11:16:26 INFO - Using env: {'DISPLAY': ':0', 11:16:26 INFO - 'HOME': '/home/cltbld', 11:16:26 INFO - 'LANG': 'en_US.UTF-8', 11:16:26 INFO - 'LANGUAGE': 'en_US:en', 11:16:26 INFO - 'LOGNAME': 'cltbld', 11:16:26 INFO - 'MAIL': '/var/mail/cltbld', 11:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:26 INFO - 'MOZ_NO_REMOTE': '1', 11:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:26 INFO - 'NO_EM_RESTART': '1', 11:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:26 INFO - 'PWD': '/builds/slave/test', 11:16:26 INFO - 'SHELL': '/bin/bash', 11:16:26 INFO - 'SHLVL': '1', 11:16:26 INFO - 'TERM': 'linux', 11:16:26 INFO - 'TMOUT': '86400', 11:16:26 INFO - 'USER': 'cltbld', 11:16:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:26 INFO - '_': '/tools/buildbot/bin/python'} 11:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 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)) 11:16:27 INFO - Cleaning up... 11:16:27 INFO - Return code: 0 11:16:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:27 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')]} 11:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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')]} 11:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:27 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 11:16:27 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 11:16:27 INFO - Using env: {'DISPLAY': ':0', 11:16:27 INFO - 'HOME': '/home/cltbld', 11:16:27 INFO - 'LANG': 'en_US.UTF-8', 11:16:27 INFO - 'LANGUAGE': 'en_US:en', 11:16:27 INFO - 'LOGNAME': 'cltbld', 11:16:27 INFO - 'MAIL': '/var/mail/cltbld', 11:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:27 INFO - 'MOZ_NO_REMOTE': '1', 11:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:27 INFO - 'NO_EM_RESTART': '1', 11:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:27 INFO - 'PWD': '/builds/slave/test', 11:16:27 INFO - 'SHELL': '/bin/bash', 11:16:27 INFO - 'SHLVL': '1', 11:16:27 INFO - 'TERM': 'linux', 11:16:27 INFO - 'TMOUT': '86400', 11:16:27 INFO - 'USER': 'cltbld', 11:16:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:27 INFO - '_': '/tools/buildbot/bin/python'} 11:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:27 INFO - Cleaning up... 11:16:27 INFO - Return code: 0 11:16:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:16:27 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')]} 11:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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')]} 11:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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 0x7f4df701bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, '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': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', '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 11:16:27 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 11:16:27 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 11:16:27 INFO - Using env: {'DISPLAY': ':0', 11:16:27 INFO - 'HOME': '/home/cltbld', 11:16:27 INFO - 'LANG': 'en_US.UTF-8', 11:16:27 INFO - 'LANGUAGE': 'en_US:en', 11:16:27 INFO - 'LOGNAME': 'cltbld', 11:16:27 INFO - 'MAIL': '/var/mail/cltbld', 11:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:27 INFO - 'MOZ_NO_REMOTE': '1', 11:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:27 INFO - 'NO_EM_RESTART': '1', 11:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:27 INFO - 'PWD': '/builds/slave/test', 11:16:27 INFO - 'SHELL': '/bin/bash', 11:16:27 INFO - 'SHLVL': '1', 11:16:27 INFO - 'TERM': 'linux', 11:16:27 INFO - 'TMOUT': '86400', 11:16:27 INFO - 'USER': 'cltbld', 11:16:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:27 INFO - '_': '/tools/buildbot/bin/python'} 11:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:27 INFO - Downloading/unpacking flake8 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:16:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:16:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:30 INFO - no previously-included directories found matching 'docs/_build' 11:16:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:16:30 INFO - Running setup.py install for pep8 11:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:30 INFO - no previously-included directories found matching 'docs/_build' 11:16:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:16:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:16:30 INFO - Cleaning up... 11:16:30 INFO - Return code: 0 11:16:30 INFO - Running post-action listener: _resource_record_post_action 11:16:30 INFO - Running post-action listener: _start_resource_monitoring 11:16:30 INFO - Starting resource monitoring. 11:16:30 INFO - ##### 11:16:30 INFO - ##### Finished create-virtualenv step (success) 11:16:30 INFO - ##### 11:16:30 INFO - ##### 11:16:30 INFO - ##### Running install step. 11:16:30 INFO - ##### 11:16:30 INFO - Running pre-action listener: _resource_record_pre_action 11:16:30 INFO - Running main action method: install 11:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:30 INFO - Reading from file tmpfile_stdout 11:16:30 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:30 INFO - Reading from file tmpfile_stdout 11:16:30 INFO - Output received: 11:16:30 INFO - Usage: mozinstall [options] installer 11:16:30 INFO - Options: 11:16:30 INFO - -h, --help show this help message and exit 11:16:30 INFO - -d DEST, --destination=DEST 11:16:30 INFO - Directory to install application into. [default: 11:16:30 INFO - "/builds/slave/test"] 11:16:30 INFO - --app=APP Application being installed. [default: firefox] 11:16:30 INFO - mkdir: /builds/slave/test/build/application 11:16:30 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'] 11:16:30 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 11:16:47 INFO - Reading from file tmpfile_stdout 11:16:47 INFO - Output received: 11:16:47 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:47 INFO - Running post-action listener: _resource_record_post_action 11:16:47 INFO - ##### 11:16:47 INFO - ##### Finished install step (success) 11:16:47 INFO - ##### 11:16:47 INFO - ##### 11:16:47 INFO - ##### Running run-tests step. 11:16:47 INFO - ##### 11:16:47 INFO - Running pre-action listener: _resource_record_pre_action 11:16:47 INFO - Running main action method: run_tests 11:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:47 INFO - Python 2.7.3 11:16:47 INFO - Return code: 0 11:16:47 INFO - grabbing minidump binary from tooltool 11:16:47 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')]} 11:16:47 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 0x2668990>, '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 0x25d4470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d4900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:47 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 11:16:47 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 11:16:47 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 11:16:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:47 INFO - Return code: 0 11:16:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:16:48 INFO - Return code: 0 11:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 11:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 11:16:48 INFO - Using env: {'DISPLAY': ':0', 11:16:48 INFO - 'HOME': '/home/cltbld', 11:16:48 INFO - 'LANG': 'en_US.UTF-8', 11:16:48 INFO - 'LANGUAGE': 'en_US:en', 11:16:48 INFO - 'LOGNAME': 'cltbld', 11:16:48 INFO - 'MAIL': '/var/mail/cltbld', 11:16:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:48 INFO - 'MOZ_NO_REMOTE': '1', 11:16:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:48 INFO - 'NO_EM_RESTART': '1', 11:16:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:48 INFO - 'PWD': '/builds/slave/test', 11:16:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:48 INFO - 'SHELL': '/bin/bash', 11:16:48 INFO - 'SHLVL': '1', 11:16:48 INFO - 'TERM': 'linux', 11:16:48 INFO - 'TMOUT': '86400', 11:16:48 INFO - 'USER': 'cltbld', 11:16:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804', 11:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:48 INFO - '_': '/tools/buildbot/bin/python'} 11:16:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 11:16:48 INFO - mozversion application_buildid: 20160623083101 11:16:48 INFO - mozversion application_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 11:16:48 INFO - mozversion application_display_name: Nightly 11:16:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:48 INFO - mozversion application_name: Firefox 11:16:48 INFO - mozversion application_remotingname: firefox 11:16:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:48 INFO - mozversion application_vendor: Mozilla 11:16:48 INFO - mozversion application_version: 50.0a1 11:16:48 INFO - mozversion platform_buildid: 20160623083101 11:16:48 INFO - mozversion platform_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 11:16:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:48 INFO - mozversion platform_version: 50.0a1 11:16:48 INFO - using testdate: 1466705808 11:16:48 INFO - actual date: 1466705808 11:16:48 INFO - starting webserver on 'localhost:50435' 11:16:48 INFO - SUITE-START | Running 2 tests 11:16:48 INFO - TEST-START | dromaeo_css 11:16:48 INFO - operating with platform_type : linux_ 11:16:48 INFO - Initialising browser for dromaeo_css test... 11:16:48 INFO - TEST-INFO | started process 17107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZjG9t/profile http://localhost:50435/getInfo.html) 11:16:53 INFO - PROCESS | 17107 | __metrics Screen width/height:1600/1200 11:16:53 INFO - PROCESS | 17107 | colorDepth:24 11:16:53 INFO - PROCESS | 17107 | Browser inner width/height: 1024/697 11:16:53 INFO - PROCESS | 17107 | __metrics 11:16:54 ERROR - PROCESS | 17107 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:16:55 INFO - TEST-INFO | 17107: exit 0 11:16:55 INFO - Browser initialized. 11:16:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:55 INFO - TEST-INFO | started process 17230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZjG9t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:07 INFO - PROCESS | 17230 | RSS: Main: 184803328 11:17:07 INFO - PROCESS | 17230 | 11:17:56 INFO - PROCESS | 17230 | 1466705876577 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] 11:20:04 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50435/tests/dromaeo/cssquery-ext.html) 11:20:05 INFO - PROCESS | 17230 | RSS: Main: 189743104 11:20:05 INFO - PROCESS | 17230 | 11:23:07 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-ext.html (next: http://localhost:50435/tests/dromaeo/cssquery-jquery.html) 11:23:08 INFO - PROCESS | 17230 | RSS: Main: 188272640 11:23:08 INFO - PROCESS | 17230 | 11:26:10 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50435/tests/dromaeo/cssquery-mootools.html) 11:26:10 INFO - PROCESS | 17230 | RSS: Main: 189382656 11:26:10 INFO - PROCESS | 17230 | 11:29:12 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50435/tests/dromaeo/cssquery-prototype.html) 11:29:13 INFO - PROCESS | 17230 | RSS: Main: 186843136 11:29:13 INFO - PROCESS | 17230 | 11:32:15 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50435/tests/dromaeo/cssquery-yui.html) 11:32:16 INFO - PROCESS | 17230 | RSS: Main: 189247488 11:32:16 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | Cycle 1(1): loaded http://localhost:50435/tests/dromaeo/cssquery-yui.html (next: http://localhost:50435/tests/dromaeo/cssquery-dojo.html) 11:35:18 INFO - PROCESS | 17230 | RSS: Main: 190005248 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | __start_tp_report 11:35:18 INFO - PROCESS | 17230 | _x_x_mozilla_page_load 11:35:18 INFO - PROCESS | 17230 | _x_x_mozilla_page_load_details 11:35:18 INFO - PROCESS | 17230 | |i|pagename|runs| 11:35:18 INFO - PROCESS | 17230 | |0;dojo.html;3125.0781019599217;3161.936761264774;3183.9044828655133;3186.9681303186976;3205.4069997050533;5453.563714902813;5454.072807622703;5508.724563771811;5539.667619942807;5553;5379.919301210485;5427.48438898305;5432.75552600133;5470.398256191816;5528.5024347808685;4858.441279252878;4899.387576552931;4986.5013498650205;5047.64666473347;5062.341895553573;687.3134411167455;4999.975000124994;5051.191809310511;5065.341505604266;5122.743862806845;4993.575546078588;5014.348134742479;5038.748062596856;5041.04220198163;5087.872803179913;4945.085159245515;5056.494350564951;5060.645754797166;5068.265101560253;5073.137566613685;4964.329815474937;4994.375703037121;5013.423456302536;5016.172331565287;5020.523050310215;5443.727813609304;5488.039593071197;5489.368722596872;5503.2020357048405;5503.642263252876;5709.77160913563;5829.912551311733;5855.209546711182;5917.6449413034925;5920.822375328747;5954.4938680212235;5979.5814292999075;5994.07091900756;6004.309504407005;6016.879662406727;5504.80733174341;5517.724113794295;5520.227168196456;5555.805546805843;5576.776928922797;5832.008558544972;6016.939830601726;6030.065339872327;6077.179580756541;6107.84730381744;5839.970800145972;5846.766129354778;5848.356680765112;5851.590388672752;5851.590388672752;5939.07944268639;5942.435468630473;5947.613405128653;5949.672767997802;5952.166696662471;5758.62568933018;5807.245058142415;5815.9709201453725;5869.090291004901;5899.46904778572;5766.163906233656;5792.420757924174;5830.47525722687;5852.619579727304;5874.089516125007;4508.391367165456;4510.864674059783;4515.119551687455;4516.458025036951;4560.794764235618;3960.7623542587535;3973.0266084809405;3987.2424239395004;4022.6982976276895;4029.1941611677194;5587.804426845041;5614.8489559640175;5662.886742265214;5677.17680936262;5678.004444952721;5756.194132821408;5941.079132734433;5974.880502389928;5974.970125149433;5989.55078369124;5566.165075238666;5578.804741834017;5582.0789569721355;5607.102863541813;5643.858903527363;5097.566706829887;5111.309973153651;5123.052235336475;5133.101707201225;5156.510131537498;5932.961731696936;6056.636601803906;6077.787277445268;6113.32753397126;6135.355787642323;5924.289085309877;5970.731317090655;5982.581219314607;5993.730282137401;6003.129546215687;6156.015037593964;6181.443670069535;6186.257649082139;6189.84525386869;6191.349908259748;5669.092945128759;5765.250517432707;5779.7110144493445;5886.381929897299;5908.379620139824;5919.822405327847;5942.168096466412;5945.64326140433;5947.286325640778;5980.671063091571;5764.423557644202;5794.18881356602;5800.332961709289;5809.2738407699035;5811.854703632443;5598.804041858515;5673.3759286477625;5688.11834165705;5763.5965482417505;5773.422657734361;5543.805966791143;5669.971650141723;5673.602847800779;5680.233168522197;5701.7434215461235;5824.621399609012;5850.765969361178;5855.3266374367495;5869.090291004901;5871.4715675589405;5557.527610153021;5635.6618602883955;5681.431856814285;5704.971475142764;5725.398833122462 11:35:18 INFO - PROCESS | 17230 | |1;ext.html;575.1114528054156;615.9507239420847;621.1676353686059;639.2584601861842;646.7768619826161;40999.38500922485;42644.78677606612;42707.359389609104;42818;46107.07785844281;44000.55999440005;44467.11065778683;44487.77756111223;44688.106237875225;44689;8869.60086796094;9007.864882026775;9019.774505637379;9036.277097832157;9039.728808135766;8842.381033327669;8880.378373513857;8958.552072396387;8975.865362019542;9002.369834111614;8984.371094023421;9009;9050.502222377767;9059.184673379394;9075.818483630323;8781.64873405063;8892;8896.51069191191;8913.465192088495;8979.10208979097;8987.46075235488;9039.457632542002;9058.411203271831;9083.954580227057;9084;41799.1640167198;42071;42246.57753422457;42296.57703422957;42465.57534424647;3082.9845850770603;3378.814165220912;3477.165480284739;3641.253543023674;3735.6077611850637;32158;33032;33339.83330083358;33469.330613387836;34359;4354;4367.627817784111;4386.013147041922;4409.184300904343;4437.6923999520395;351411;352894;353399.2330038359;355677;357554;34356;53993.46006539963;54033.729831351375;54340.18489722657;54502;34147.14632134167;36175.27649447049;36454.27091458209;36597.817010914776;36711.816440918155;15163.469278575198;15458.38166473351;15480.303386347641;15550.222488875512;15600.843991560167;13355.799663005062;13451.461941522426;13468.191908485327;13479.595612131652;13510.662233444045;8303.626336814857;8328.250457458858;8378.748637540884;8406.705765298308;8425.83148337042;3191.2181515528846;3218.6942240487115;3280.6391296957318;3280.9015729527673;3285.7535684823733;970.0784254957819;979.7942432089341;995.1690338567232;1000.2548101664162;1052.1109662335314;31911.52132718011;32743;32771.34457310888;32902.177445564055;32951.50572741411;1069.187417562658;1124.145649306533;1126.3410904620725;1132.6432173865205;1154.4112502623723;16598.41905533325;16932.830671693126;16968.15159242033;17162.914185428992;17587.29650813953;518438;518465;518869;521769;524029;57866;58280;58375.12437313444;58430.70784646049;58439;1326.5622344626443;1338.5716570697477;1354.8145372798997;1358.9660258493418;1360.1363134409721;29826.85086574553;30845.845770771004;31558.211044724067;31584;32126.678733212368;49910.75044624753;54023.729881350344;56128;56498;60048.39951600603;469347;472421;475072;476025;478196;44023.339649905916;44271;44475;44835.77582112069;45521.544784551734;48715.5128448711;49232.261516078004;49420;50084;50717.23924141215;41435.585644143175;41960;42101.36847947222;42279.788601056796;42685.57314426816;40832;41315.380269296584;42143.57856421397;42722.57277427186;43034.78482607567;41110.588894110675;41807.581924181584;41857;42164.578354216064;42214;35462.82268588641;37271.62728372682;37750.811245943594;38321.80839095786;38465.42301865418;28263.576046359733;28687.282817929718;28851.71148288574;28869.711302886702;29154.708452915198 11:35:18 INFO - PROCESS | 17230 | |2;jquery.html;396.58754894909316;402.42855145693113;403.5097356711595;404.8400881651748;413.60522574294833;13737.519186828464;18074.457766267;18948.336808211716;19554.511137221576;19728.01359932003;18899.24403023881;18901.905490472564;19352.419427417164;19561.41315760526;19716.408507744756;5316.0962636351915;5578.9163162552595;5610.551155907538;5611.046122159243;5816.1275808628625;5195.246689230059;5525.336959564858;5638.210650508932;5651.886962260753;5689.146628005811;5564.054110801153;5572.7770889164385;5580.944190558103;5590.944090559083;5595.916061259084;5672.659640421567;5701.515371193454;5751;5761.9916514610195;5770.019096753541;5403.729813509309;5557.166425036236;5568.693721845297;5576.693281869496;5592.412796656374;13843.792343114861;13846.446142154302;13848.307584620728;18587;22387.10451581935;2310.560993411263;2450.3751543356507;2620.2139358192658;2725.2914242296947;2969.539721343195;10163.390196588154;10187.745306367326;10228.89771102287;10313.48432578368;10642;1898.5538398476347;1960.7156962240538;1964.1161477335256;1967.8425725942034;2008.9296874609465;79926.20073799246;80647;82539.58730206371;84072;85030.14969850284;10603.41681207541;10828.133749300037;10843.969822866815;10976.286541374786;11202.103831693445;15022;15024.474143404928;15025.474108406153;15230.238488075773;15245.23773811305;7981.72063977758;8370.497770133812;8494.362922780816;8532.70135545253;8547.316214702809;7719.838445235343;7749.8450030999065;7886.487378320506;7906.723264685708;7936;4644.303354496852;4759.405074365704;4790.688605240648;4792.376990991149;4859.538343857328;1921.1834970137636;1937.5834195648004;1972.477293517219;1991.084101313412;2053.7638171610156;839.3117643532368;911.5487833522449;950.3442624589012;982.749398903275;994.5176589354157;17736.822631773517;18792.248310067444;19348.805745948768;19524.12141453638;19844.404667859988;944.2021491839384;962.855571664242;1004.9598016079422;1024.155072065549;1057.7672911959357;10395.740106497247;10631.681049568526;10925.235233533576;11051.834222486668;11218.214724969173;455371;456829;459755;461754;466371;79387;90488.54755726179;92418;93866.53066734623;95047;1017.1100287248657;1051.7475805806705;1052.768390953989;1064.6539874540806;1065.760203954104;17201.397951072155;17389.91305043467;17455.476335709947;17578.12109394551;17877.195526201092;32839.01482955515;40958.59041409667;41271.380929285486;41312.38031429471;42833.35749963815;55215.17177242425;56515.71742141263;56880.146797798894;57424.425755741904;57813.4218657808;7479.476436649382;7750.10873749526;7841.686332546634;8455.66177352899;8812.030676625438;9211.76970575741;12353.505859765508;13446.260455675032;13676.863231367957;14110.788338175142;11835.28988260707;11883.108766842348;12109.515619375126;12313.507459701512;12338.444769985552;12033.819492707791;12073.39633018328;12126;12224.388780561114;12321.568745093879;10762.19283553721;10792.730181745519;11914;12008.519659213534;12607.369631518572;7422.888656670262;7847.568383738949;7847.646855891385;8693.39146259781;8965.955170224108;8910.108989101298;10786.838197427202;10894.400807955639;11223.102151827998;11468.65594032147 11:35:18 INFO - PROCESS | 17230 | |3;mootools.html;1474.167095590991;1480.097140744146;1596.1221328269448;1709.640975395167;1751.7197248440252;7904.683812647487;8382.497050176993;8566.143385661439;9068.3198760093;9082.364234503579;8518.148185181479;8714.694985675487;8718.651253949834;8775.6050977706;8808.735737927873;2314.849534780238;2343.5547246023284;2352.4706940938236;2353.9411514712183;2361.7756313150308;2302.9309120726407;2317.1889838556453;2334.6381310896754;2340.32130682102;2351.1888398502488;2298.390926404504;2301.1945818963395;2333.9533209335805;2341.7424083350816;2348.5655153796515;2273.954520909581;2274.9090036398525;2290.7365652949957;2311.05246848792;2312.109837712476;2301.5396920615945;2319.93040208794;2331.4754180309465;2333.57995560799;2333.94165145871;8835.514046727427;8924.330675199386;8924.509151996637;8932.419392739452;8939.374243802937;5213.7393130343335;5300.496452836975;5347.438518955531;5353.9196912046355;5360.088784906575;3219.8551065201887;3297.686719761619;3372.532948167555;3437.3125374925116;3454.6890779829687;1110.0453609895483;1126.7126882644955;1127.932324060559;1150.8331291962702;1175.870654228043;12172.513099476011;12255.69360765979;12273.324967126804;12295.385230738517;12327.568535101318;4390.165868485042;4437.489688685778;4562.1560011398;4564.726116432958;4573.977130114328;10424.218183636258;10472.266941314036;10487.161027117812;10526.789464210826;10532.736681583021;5187.507186817246;5213.087709650796;5226.477352264743;5247.212918062245;5247.553957913544;4229.45017147775;4696.459907110658;4708.576228139484;4817.542333478314;4844.491328410466;3874.535055793323;3921.9019524512114;3936.527616686016;3992.6007399259843;4001.4397984282223;1244.1415423357855;1247.0857234145542;1248.7190382164122;1269.6127681057183;1299.402274953532;777.1218523069009;879.2658130461009;913.3925939250324;974.9415035097917;993.7764003099245;6009.699515024231;6119.602225855305;6165.907511387333;6280.340564240781;6476.805695829133;951.5813042261383;952.9237660987104;996.5465713100522;1016.6086056868158;1019.918406527476;4144.91710165795;4278.786060697015;4321.395004699345;4373.540778218305;4373.650107991353;11012.834807477895;11184.44077796107;11305.773884522428;11325.32048077118;11338.09295256394;10239.283250172566;10622.20333474977;11234.943825280821;11247.943760281147;11266.718332041764;8102;8259.42184047111;8264.090949995616;8294.170582941779;8317.750467485985;6169.598976066542;6243.906341404973;6433.903491447726;6442.065900444316;6455.548111632141;10200.795984080425;10221;10257.33327333721;10294.176465882561;10356.844647330145;10243.539040743333;10585.682429527127;10592.258541901992;10652.147828173573;10719.624813131502;7275.126984761862;7493.737719179802;7759.340456061298;7773.222677732181;7958.602069896367;8742.956285218534;8762.693305734269;8792.956035219782;8814.647414103363;8852.291816654524;7676;7794.883076753967;7903.802404939923;7946.8807967879375;7984.840303193788;7345.742898998509;7744.57404842739;7790.766277011699;7871.606419679108;7908.169642187488;7040.683169257293;7160.892586611101;7222.349988501061;7245.5652660840515;7252.637368131678;5321.866953326198;5331.546818520469;5454.4272851351625;5465.016297066407;5493.2034854946605;5148.845534633967;5355.812546560852;5361.437049109787;5362.605722512097;5396.1366181410785 11:35:18 INFO - PROCESS | 17230 | |4;prototype.html;320.3273126434487;324.2736270753512;328.985195666195;331.19684764446225;336.94103531881916;5574.888502229953;5618.438156184385;5637.915431268534;5639.6334238274485;5674.177244299574;5558.416366281533;5569.721513924308;5577.191307260455;5601.439856014396;5619.971900140504;4139.3583994480905;4150.43969064177;4243.72415792974;4251.171021650779;4265.658747300224;4246.766427846467;4262.318029115342;4265.957340426603;4278.315469524877;4298.978505107486;4255.680823938202;4269.402283680287;4286;4292.248856450125;4295.892602684927;4020.155767288873;4236.406903033578;4245.1934132514725;4259.488861336628;4288.292431748758;3662.4872517847257;3702.6118153790653;3703.5000274962804;3716.089558058266;3741.3639681254253;5357.223202635596;5413.64811287269;5414.835810300765;5419.34967803866;5453.3728621208675;4723.645726570487;4922.778474968635;4937.456879743226;4940.407151141886;4959.256111583255;5883.17635531026;5903.321118071433;5903.439173278532;5908.911366329508;5910.083936989773;4107.938380924288;4117.691173161995;4119.176164767058;4141.875743727693;4161.8959526012095;5915.438033386865;6090.086487026982;6113.32753397126;6130.356312587203;6157.938420615781;4165.937510937339;4185.832566697298;4202.432671589358;4231.555686652919;4249.490061192615;4270.829166833292;4287.356896465555;4289.528151903288;4303.892402689958;4307.870763877088;4650.186217412007;4914.574773315699;4919.1883339248625;4960.528749768766;4963.60291176705;5882.058870580687;5882.323532793698;5905.1142328650185;5906.763729450774;5925.970370148208;1465.5456808389433;1472.85271472854;1481.5555333399936;1487.8171853376375;1488.8064551608222;941.8869735631768;961.6538046303325;968.7287559483356;996.5266498413196;1012.9290949633455;5603.6077474577205;5666.858328541737;5678.432156784371;5685.317761868602;5713.942860571424;5976.193213916153;5995.730192141364;5998.790042348497;6009.879802403927;6073.908891366633;5392.784288628411;5633.746481408347;5681.914771278434;5701.543876489954;5712.428757124254;3173.1591128351006;3204.919877003047;3205.406999705062;3206.8556914938886;3221.194701324669;6126.079309242089;6143.232095988002;6215.595986260879;6266.780662676784;6268.529860260499;6134.723937422827;6143.293521245025;6154.846128846814;6225.443639090227;6250.343713910065;6116.418940200674;6233.875322493524;6236.875262494725;6284.497240220771;6294.590851594632;6057.909131362945;6076.693510895002;6077.756889724362;6077.969610152098;6100.908486372797;5988;5999.760009599567;6081.787137450168;6122.510199184144;6144.170536977451;5913.822585322448;6169.444749972524;6235.314115447388;6282.465990390868;6316;4162.62633330994;4168.4997800262945;4172.497900755786;4190.580941905785;4204.558521355214;5843.211166492469;5948.583599148191;6065.8474889770805;6091.177691011657;6119.173911521888;5903.350631430453;5932.940670593239;5964.582479226413;5968.582199246011;5970.313413957277;5833.562482813721;5896.49879760208;5945.227120474311;5965.880682386415;5982.371850955761;5586.273784408001;5779.393163717918;5790.536757059341;5808.605934575756;5868.474196708972;5896.292444906639;5970.00004998313;5975.028240680652;5988.910166347596;6012.549058820693;5677.971610141923;5747.476918616487;5759.51044161251;5816.371416003526;5860.501857342003 11:35:18 INFO - PROCESS | 17230 | |5;yui.html;680.9046733457317;757.2919320435393;800.1718221640604;800.2277801921141;822.9958850205749;15315.310811013504;16621.41825036124;16634.916825415887;16673.333066677333;16786.832131678693;15004;15070.17114058729;15198.620034499143;15205.54383368498;15227;658.6410406328563;773.5358784729174;782.3701919954434;790.3479629305817;792.3621484704839;779.9961000195019;783.7883771381723;785.0618510879501;786.6027656033724;791.2759824760337;850.9872351914695;855.7218903856271;855.7603870916154;855.9058503564634;856.1866227084295;848.5799529233008;849.0617867256716;849.3757088539949;851.5231470376578;852.6930305090162;614.2383444528753;618.5917294585597;619.2414292491707;619.2970977940025;623.4949690750507;14547.70904581913;14617.269136543131;14622.415103395851;14629;14698.485553005594;14820.481283155146;15053.623659408602;15320.693586128327;15347.309371078216;15544.844551554454;11640.66132394777;11714.117279883503;12037.578684745991;12052.879471205264;12433.005359571212;4332.891677708051;4367;4398.164348773723;4409.140217657558;4457.398251236074;77294.61352693258;77570;77834;78232;79806.6009669948;10929.890701092887;10934.945325273322;10956.616518421817;10969.122470202365;10981.670549883516;19863.900680496794;19953.700694489595;20000.59998800045;20019.199232030554;20052.097655605532;8117.188281171953;8175.427720059658;8252.05101413345;8351.24838764514;8378.455400398954;4655.649861540183;4719.858404247878;4777.307290442866;4803.207470767354;4935.62982776286;3442.5008373785663;3541.9291614167573;3542.220711443478;3544.8759293424605;3550.8757193498104;635.4979566142788;637.9043143528415;645.9967700161563;649.1074772188241;649.2857856357969;505.29511331692083;559.6362364463132;604.9001914684028;652.9934700652933;673.8416472129046;8718.738437846874;8784.822765851222;8911.55442227886;8990.55047247635;9136.314776391797;620.7020630097578;673.6934694713893;680.2041611314773;693.2859155070286;717.9820504487429;4349.478062632441;4419.226635338803;4438.334249862546;4493.707908985905;4505.301678239878;66661.6666916672;67206.66396668083;67315.32684673091;67414.3258567408;106367.93632063735;60993;63421.36578634247;67412;84353;101427.49286253522;77778.61110694411;78487;88604.556977216;88995.11004889868;92083;8244.381671374791;8315.916840831756;8355.45689530203;8452.704155354533;8613.526256055977;49742;51766;51879.22181167361;52457.47542524526;53674.46325536851;57803.71098144651;74742;75618;76280.61859690888;76331;11324.660260192208;11502.252353596989;11607.129465289969;11772.941135294268;11781.352025638329;12317.815232771336;12605.936970315457;12869.678258043623;12881.48474061027;12893;11543.365114918424;11973.161878668758;12157.513699452276;12192.57325993586;12243.510259589517;11444.198906076495;11528;11579.13156513248;11591.304521728724;11789;11404.429778511207;11565.421728913689;11915.165938384576;13043.413046413123;13049.478020879058;10908.2364234506;11162.944185279346;11273.267237629529;11761.294322340687;12127.664867285186;11492;11700.88299117032;11834.76330473403;11905.82141267899;11954.342511161969 11:35:18 INFO - PROCESS | 17230 | __end_tp_report 11:35:18 INFO - PROCESS | 17230 | __start_cc_report 11:35:18 INFO - PROCESS | 17230 | _x_x_mozilla_cycle_collect,342 11:35:18 INFO - PROCESS | 17230 | __end_cc_report 11:35:18 INFO - PROCESS | 17230 | __startTimestamp1466706918902__endTimestamp 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | ------- Summary: start ------- 11:35:18 INFO - PROCESS | 17230 | Number of tests: 6 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#0] dojo.html Cycles:165 Average:5458.00 Median:5680.23 stddev:730.67 (12.9%) stddev-sans-first:709.62 11:35:18 INFO - PROCESS | 17230 | Values: 3125.1 3161.9 3183.9 3187.0 3205.4 5453.6 5454.1 5508.7 5539.7 5553.0 5379.9 5427.5 5432.8 5470.4 5528.5 4858.4 4899.4 4986.5 5047.6 5062.3 687.3 5000.0 5051.2 5065.3 5122.7 4993.6 5014.3 5038.7 5041.0 5087.9 4945.1 5056.5 5060.6 5068.3 5073.1 4964.3 4994.4 5013.4 5016.2 5020.5 5443.7 5488.0 5489.4 5503.2 5503.6 5709.8 5829.9 5855.2 5917.6 5920.8 5954.5 5979.6 5994.1 6004.3 6016.9 5504.8 5517.7 5520.2 5555.8 5576.8 5832.0 6016.9 6030.1 6077.2 6107.8 5840.0 5846.8 5848.4 5851.6 5851.6 5939.1 5942.4 5947.6 5949.7 5952.2 5758.6 5807.2 5816.0 5869.1 5899.5 5766.2 5792.4 5830.5 5852.6 5874.1 4508.4 4510.9 4515.1 4516.5 4560.8 3960.8 3973.0 3987.2 4022.7 4029.2 5587.8 5614.8 5662.9 5677.2 5678.0 5756.2 5941.1 5974.9 5975.0 5989.6 5566.2 5578.8 5582.1 5607.1 5643.9 5097.6 5111.3 5123.1 5133.1 5156.5 5933.0 6056.6 6077.8 6113.3 6135.4 5924.3 5970.7 5982.6 5993.7 6003.1 6156.0 6181.4 6186.3 6189.8 6191.3 5669.1 5765.3 5779.7 5886.4 5908.4 5919.8 5942.2 5945.6 5947.3 5980.7 5764.4 5794.2 5800.3 5809.3 5811.9 5598.8 5673.4 5688.1 5763.6 5773.4 5543.8 5670.0 5673.6 5680.2 5701.7 5824.6 5850.8 5855.3 5869.1 5871.5 5557.5 5635.7 5681.4 5705.0 5725.4 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#1] ext.html Cycles:180 Average:60450.63 Median:42555.18 stddev:120732.89 (283.7%) stddev-sans-first:120987.88 11:35:18 INFO - PROCESS | 17230 | Values: 575.1 616.0 621.2 639.3 646.8 40999.4 42644.8 42707.4 42818.0 46107.1 44000.6 44467.1 44487.8 44688.1 44689.0 8869.6 9007.9 9019.8 9036.3 9039.7 8842.4 8880.4 8958.6 8975.9 9002.4 8984.4 9009.0 9050.5 9059.2 9075.8 8781.6 8892.0 8896.5 8913.5 8979.1 8987.5 9039.5 9058.4 9084.0 9084.0 41799.2 42071.0 42246.6 42296.6 42465.6 3083.0 3378.8 3477.2 3641.3 3735.6 32158.0 33032.0 33339.8 33469.3 34359.0 4354.0 4367.6 4386.0 4409.2 4437.7 351411.0 352894.0 353399.2 355677.0 357554.0 34356.0 53993.5 54033.7 54340.2 54502.0 34147.1 36175.3 36454.3 36597.8 36711.8 15163.5 15458.4 15480.3 15550.2 15600.8 13355.8 13451.5 13468.2 13479.6 13510.7 8303.6 8328.3 8378.7 8406.7 8425.8 3191.2 3218.7 3280.6 3280.9 3285.8 970.1 979.8 995.2 1000.3 1052.1 31911.5 32743.0 32771.3 32902.2 32951.5 1069.2 1124.1 1126.3 1132.6 1154.4 16598.4 16932.8 16968.2 17162.9 17587.3 518438.0 518465.0 518869.0 521769.0 524029.0 57866.0 58280.0 58375.1 58430.7 58439.0 1326.6 1338.6 1354.8 1359.0 1360.1 29826.9 30845.8 31558.2 31584.0 32126.7 49910.8 54023.7 56128.0 56498.0 60048.4 469347.0 472421.0 475072.0 476025.0 478196.0 44023.3 44271.0 44475.0 44835.8 45521.5 48715.5 49232.3 49420.0 50084.0 50717.2 41435.6 41960.0 42101.4 42279.8 42685.6 40832.0 41315.4 42143.6 42722.6 43034.8 41110.6 41807.6 41857.0 42164.6 42214.0 35462.8 37271.6 37750.8 38321.8 38465.4 28263.6 28687.3 28851.7 28869.7 29154.7 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#2] jquery.html Cycles:180 Average:27806.48 Median:17904.28 stddev:76037.81 (424.7%) stddev-sans-first:76223.26 11:35:18 INFO - PROCESS | 17230 | Values: 396.6 402.4 403.5 404.8 413.6 13737.5 18074.5 18948.3 19554.5 19728.0 18899.2 18901.9 19352.4 19561.4 19716.4 5316.1 5578.9 5610.6 5611.0 5816.1 5195.2 5525.3 5638.2 5651.9 5689.1 5564.1 5572.8 5580.9 5590.9 5595.9 5672.7 5701.5 5751.0 5762.0 5770.0 5403.7 5557.2 5568.7 5576.7 5592.4 13843.8 13846.4 13848.3 18587.0 22387.1 2310.6 2450.4 2620.2 2725.3 2969.5 10163.4 10187.7 10228.9 10313.5 10642.0 1898.6 1960.7 1964.1 1967.8 2008.9 79926.2 80647.0 82539.6 84072.0 85030.1 10603.4 10828.1 10844.0 10976.3 11202.1 15022.0 15024.5 15025.5 15230.2 15245.2 7981.7 8370.5 8494.4 8532.7 8547.3 7719.8 7749.8 7886.5 7906.7 7936.0 4644.3 4759.4 4790.7 4792.4 4859.5 1921.2 1937.6 1972.5 1991.1 2053.8 839.3 911.5 950.3 982.7 994.5 17736.8 18792.2 19348.8 19524.1 19844.4 944.2 962.9 1005.0 1024.2 1057.8 10395.7 10631.7 10925.2 11051.8 11218.2 455371.0 456829.0 459755.0 461754.0 466371.0 79387.0 90488.5 92418.0 93866.5 95047.0 1017.1 1051.7 1052.8 1064.7 1065.8 17201.4 17389.9 17455.5 17578.1 17877.2 32839.0 40958.6 41271.4 41312.4 42833.4 55215.2 56515.7 56880.1 57424.4 57813.4 7479.5 7750.1 7841.7 8455.7 8812.0 9211.8 12353.5 13446.3 13676.9 14110.8 11835.3 11883.1 12109.5 12313.5 12338.4 12033.8 12073.4 12126.0 12224.4 12321.6 10762.2 10792.7 11914.0 12008.5 12607.4 7422.9 7847.6 7847.6 8693.4 8966.0 8910.1 10786.8 10894.4 11223.1 11468.7 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#3] mootools.html Cycles:180 Average:5876.10 Median:4563.44 stddev:3344.37 (73.3%) stddev-sans-first:3337.40 11:35:18 INFO - PROCESS | 17230 | Values: 1474.2 1480.1 1596.1 1709.6 1751.7 7904.7 8382.5 8566.1 9068.3 9082.4 8518.1 8714.7 8718.7 8775.6 8808.7 2314.8 2343.6 2352.5 2353.9 2361.8 2302.9 2317.2 2334.6 2340.3 2351.2 2298.4 2301.2 2334.0 2341.7 2348.6 2274.0 2274.9 2290.7 2311.1 2312.1 2301.5 2319.9 2331.5 2333.6 2333.9 8835.5 8924.3 8924.5 8932.4 8939.4 5213.7 5300.5 5347.4 5353.9 5360.1 3219.9 3297.7 3372.5 3437.3 3454.7 1110.0 1126.7 1127.9 1150.8 1175.9 12172.5 12255.7 12273.3 12295.4 12327.6 4390.2 4437.5 4562.2 4564.7 4574.0 10424.2 10472.3 10487.2 10526.8 10532.7 5187.5 5213.1 5226.5 5247.2 5247.6 4229.5 4696.5 4708.6 4817.5 4844.5 3874.5 3921.9 3936.5 3992.6 4001.4 1244.1 1247.1 1248.7 1269.6 1299.4 777.1 879.3 913.4 974.9 993.8 6009.7 6119.6 6165.9 6280.3 6476.8 951.6 952.9 996.5 1016.6 1019.9 4144.9 4278.8 4321.4 4373.5 4373.7 11012.8 11184.4 11305.8 11325.3 11338.1 10239.3 10622.2 11234.9 11247.9 11266.7 8102.0 8259.4 8264.1 8294.2 8317.8 6169.6 6243.9 6433.9 6442.1 6455.5 10200.8 10221.0 10257.3 10294.2 10356.8 10243.5 10585.7 10592.3 10652.1 10719.6 7275.1 7493.7 7759.3 7773.2 7958.6 8743.0 8762.7 8793.0 8814.6 8852.3 7676.0 7794.9 7903.8 7946.9 7984.8 7345.7 7744.6 7790.8 7871.6 7908.2 7040.7 7160.9 7222.3 7245.6 7252.6 5321.9 5331.5 5454.4 5465.0 5493.2 5148.8 5355.8 5361.4 5362.6 5396.1 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#4] prototype.html Cycles:180 Average:4927.92 Median:5676.07 stddev:1482.45 (26.1%) stddev-sans-first:1445.71 11:35:18 INFO - PROCESS | 17230 | Values: 320.3 324.3 329.0 331.2 336.9 5574.9 5618.4 5637.9 5639.6 5674.2 5558.4 5569.7 5577.2 5601.4 5620.0 4139.4 4150.4 4243.7 4251.2 4265.7 4246.8 4262.3 4266.0 4278.3 4299.0 4255.7 4269.4 4286.0 4292.2 4295.9 4020.2 4236.4 4245.2 4259.5 4288.3 3662.5 3702.6 3703.5 3716.1 3741.4 5357.2 5413.6 5414.8 5419.3 5453.4 4723.6 4922.8 4937.5 4940.4 4959.3 5883.2 5903.3 5903.4 5908.9 5910.1 4107.9 4117.7 4119.2 4141.9 4161.9 5915.4 6090.1 6113.3 6130.4 6157.9 4165.9 4185.8 4202.4 4231.6 4249.5 4270.8 4287.4 4289.5 4303.9 4307.9 4650.2 4914.6 4919.2 4960.5 4963.6 5882.1 5882.3 5905.1 5906.8 5926.0 1465.5 1472.9 1481.6 1487.8 1488.8 941.9 961.7 968.7 996.5 1012.9 5603.6 5666.9 5678.4 5685.3 5713.9 5976.2 5995.7 5998.8 6009.9 6073.9 5392.8 5633.7 5681.9 5701.5 5712.4 3173.2 3204.9 3205.4 3206.9 3221.2 6126.1 6143.2 6215.6 6266.8 6268.5 6134.7 6143.3 6154.8 6225.4 6250.3 6116.4 6233.9 6236.9 6284.5 6294.6 6057.9 6076.7 6077.8 6078.0 6100.9 5988.0 5999.8 6081.8 6122.5 6144.2 5913.8 6169.4 6235.3 6282.5 6316.0 4162.6 4168.5 4172.5 4190.6 4204.6 5843.2 5948.6 6065.8 6091.2 6119.2 5903.4 5932.9 5964.6 5968.6 5970.3 5833.6 5896.5 5945.2 5965.9 5982.4 5586.3 5779.4 5790.5 5808.6 5868.5 5896.3 5970.0 5975.0 5988.9 6012.5 5678.0 5747.5 5759.5 5816.4 5860.5 11:35:18 INFO - PROCESS | 17230 | 11:35:18 INFO - PROCESS | 17230 | [#5] yui.html Cycles:180 Average:18744.55 Median:4869.42 stddev:25572.27 (525.2%) stddev-sans-first:25608.04 11:35:18 INFO - PROCESS | 17230 | Values: 680.9 757.3 800.2 800.2 823.0 15315.3 16621.4 16634.9 16673.3 16786.8 15004.0 15070.2 15198.6 15205.5 15227.0 658.6 773.5 782.4 790.3 792.4 780.0 783.8 785.1 786.6 791.3 851.0 855.7 855.8 855.9 856.2 848.6 849.1 849.4 851.5 852.7 614.2 618.6 619.2 619.3 623.5 14547.7 14617.3 14622.4 14629.0 14698.5 14820.5 15053.6 15320.7 15347.3 15544.8 11640.7 11714.1 12037.6 12052.9 12433.0 4332.9 4367.0 4398.2 4409.1 4457.4 77294.6 77570.0 77834.0 78232.0 79806.6 10929.9 10934.9 10956.6 10969.1 10981.7 19863.9 19953.7 20000.6 20019.2 20052.1 8117.2 8175.4 8252.1 8351.2 8378.5 4655.6 4719.9 4777.3 4803.2 4935.6 3442.5 3541.9 3542.2 3544.9 3550.9 635.5 637.9 646.0 649.1 649.3 505.3 559.6 604.9 653.0 673.8 8718.7 8784.8 8911.6 8990.6 9136.3 620.7 673.7 680.2 693.3 718.0 4349.5 4419.2 4438.3 4493.7 4505.3 66661.7 67206.7 67315.3 67414.3 106367.9 60993.0 63421.4 67412.0 84353.0 101427.5 77778.6 78487.0 88604.6 88995.1 92083.0 8244.4 8315.9 8355.5 8452.7 8613.5 49742.0 51766.0 51879.2 52457.5 53674.5 57803.7 74742.0 75618.0 76280.6 76331.0 11324.7 11502.3 11607.1 11772.9 11781.4 12317.8 12605.9 12869.7 12881.5 12893.0 11543.4 11973.2 12157.5 12192.6 12243.5 11444.2 11528.0 11579.1 11591.3 11789.0 11404.4 11565.4 11915.2 13043.4 13049.5 10908.2 11162.9 11273.3 11761.3 12127.7 11492.0 11700.9 11834.8 11905.8 11954.3 11:35:18 INFO - PROCESS | 17230 | -------- Summary: end -------- 11:35:18 INFO - PROCESS | 17230 | 11:35:19 INFO - TEST-INFO | 17230: exit 0 11:35:19 INFO - TEST-OK | dromaeo_css | took 1110667ms 11:35:19 INFO - TEST-START | kraken 11:35:19 INFO - operating with platform_type : linux_ 11:35:19 INFO - Initialising browser for kraken test... 11:35:19 INFO - TEST-INFO | started process 17474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2A7e_W/profile http://localhost:50435/getInfo.html) 11:35:24 INFO - PROCESS | 17474 | __metrics Screen width/height:1600/1200 11:35:24 INFO - PROCESS | 17474 | colorDepth:24 11:35:24 INFO - PROCESS | 17474 | Browser inner width/height: 1024/697 11:35:24 INFO - PROCESS | 17474 | __metrics 11:35:24 ERROR - PROCESS | 17474 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:35:25 INFO - TEST-INFO | 17474: exit 0 11:35:25 INFO - Browser initialized. 11:35:25 INFO - Running cycle 1/1 for kraken test... 11:35:25 INFO - TEST-INFO | started process 17591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2A7e_W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:37 INFO - PROCESS | 17591 | RSS: Main: 185053184 11:35:37 INFO - PROCESS | 17591 | 11:35:40 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50435/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:41 INFO - PROCESS | 17591 | RSS: Main: 190590976 11:35:41 INFO - PROCESS | 17591 | 11:35:43 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50435/tests/kraken/driver.html?testName=audio-dft) 11:35:44 INFO - PROCESS | 17591 | RSS: Main: 189833216 11:35:44 INFO - PROCESS | 17591 | 11:35:47 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50435/tests/kraken/driver.html?testName=audio-fft) 11:35:47 INFO - PROCESS | 17591 | RSS: Main: 185810944 11:35:47 INFO - PROCESS | 17591 | 11:35:50 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50435/tests/kraken/driver.html?testName=audio-oscillator) 11:35:50 INFO - PROCESS | 17591 | RSS: Main: 186388480 11:35:50 INFO - PROCESS | 17591 | 11:35:53 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:53 INFO - PROCESS | 17591 | RSS: Main: 187047936 11:35:53 INFO - PROCESS | 17591 | 11:35:56 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50435/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:57 INFO - PROCESS | 17591 | RSS: Main: 186929152 11:35:57 INFO - PROCESS | 17591 | 11:36:00 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50435/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:01 INFO - PROCESS | 17591 | RSS: Main: 187224064 11:36:01 INFO - PROCESS | 17591 | 11:36:04 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50435/tests/kraken/driver.html?testName=json-parse-financial) 11:36:05 INFO - PROCESS | 17591 | RSS: Main: 187035648 11:36:05 INFO - PROCESS | 17591 | 11:36:06 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:07 INFO - PROCESS | 17591 | RSS: Main: 187023360 11:36:07 INFO - PROCESS | 17591 | 11:36:09 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:09 INFO - PROCESS | 17591 | RSS: Main: 186900480 11:36:09 INFO - PROCESS | 17591 | 11:36:11 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:12 INFO - PROCESS | 17591 | RSS: Main: 187215872 11:36:12 INFO - PROCESS | 17591 | 11:36:15 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:15 INFO - PROCESS | 17591 | RSS: Main: 188243968 11:36:15 INFO - PROCESS | 17591 | 11:36:18 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:19 INFO - PROCESS | 17591 | RSS: Main: 187756544 11:36:19 INFO - PROCESS | 17591 | 11:36:20 INFO - PROCESS | 17591 | Cycle 1(1): loaded http://localhost:50435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50435/tests/kraken/driver.html?testName=ai-astar) 11:36:21 INFO - PROCESS | 17591 | RSS: Main: 189288448 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | __start_tp_report 11:36:21 INFO - PROCESS | 17591 | _x_x_mozilla_page_load 11:36:21 INFO - PROCESS | 17591 | _x_x_mozilla_page_load_details 11:36:21 INFO - PROCESS | 17591 | |i|pagename|runs| 11:36:21 INFO - PROCESS | 17591 | |0;ai-astar;101;111;104;110;111;109;112;110;110;111 11:36:21 INFO - PROCESS | 17591 | |1;audio-beat-detection;158;125;152;182;142;150;154;133;188;126 11:36:21 INFO - PROCESS | 17591 | |2;audio-dft;163;162;162;162;165;173;164;163;162;163 11:36:21 INFO - PROCESS | 17591 | |3;audio-fft;88;76;76;162;75;75;75;75;164;75 11:36:21 INFO - PROCESS | 17591 | |4;audio-oscillator;89;85;154;84;85;86;132;85;84;154 11:36:21 INFO - PROCESS | 17591 | |5;imaging-gaussian-blur;117;117;117;117;118;118;121;120;119;119 11:36:21 INFO - PROCESS | 17591 | |6;imaging-darkroom;148;147;148;148;148;147;146;148;149;147 11:36:21 INFO - PROCESS | 17591 | |7;imaging-desaturate;95;96;97;95;96;96;96;97;97;95 11:36:21 INFO - PROCESS | 17591 | |8;json-parse-financial;57;57;60;57;59;62;60;56;57;60 11:36:21 INFO - PROCESS | 17591 | |9;json-stringify-tinderbox;62;62;62;61;62;61;61;62;61;61 11:36:21 INFO - PROCESS | 17591 | |10;stanford-crypto-aes;79;85;86;85;81;81;81;82;98;79 11:36:21 INFO - PROCESS | 17591 | |11;stanford-crypto-ccm;124;122;125;125;140;130;123;135;128;130 11:36:21 INFO - PROCESS | 17591 | |12;stanford-crypto-pbkdf2;167;165;169;170;164;166;161;167;162;160 11:36:21 INFO - PROCESS | 17591 | |13;stanford-crypto-sha256-iterative;70;64;66;65;63;66;61;62;64;63 11:36:21 INFO - PROCESS | 17591 | __end_tp_report 11:36:21 INFO - PROCESS | 17591 | __start_cc_report 11:36:21 INFO - PROCESS | 17591 | _x_x_mozilla_cycle_collect,910 11:36:21 INFO - PROCESS | 17591 | __end_cc_report 11:36:21 INFO - PROCESS | 17591 | __startTimestamp1466706981043__endTimestamp 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | ------- Summary: start ------- 11:36:21 INFO - PROCESS | 17591 | Number of tests: 14 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.50 stddev:3.54 (3.2%) stddev-sans-first:2.33 11:36:21 INFO - PROCESS | 17591 | Values: 101.0 111.0 104.0 110.0 111.0 109.0 112.0 110.0 110.0 111.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.00 stddev:21.33 (13.9%) stddev-sans-first:22.48 11:36:21 INFO - PROCESS | 17591 | Values: 158.0 125.0 152.0 182.0 142.0 150.0 154.0 133.0 188.0 126.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.35 (2.1%) stddev-sans-first:3.54 11:36:21 INFO - PROCESS | 17591 | Values: 163.0 162.0 162.0 162.0 165.0 173.0 164.0 163.0 162.0 163.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:36.53 (48.7%) stddev-sans-first:38.68 11:36:21 INFO - PROCESS | 17591 | Values: 88.0 76.0 76.0 162.0 75.0 75.0 75.0 75.0 164.0 75.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:85.00 stddev:30.21 (35.5%) stddev-sans-first:31.57 11:36:21 INFO - PROCESS | 17591 | Values: 89.0 85.0 154.0 84.0 85.0 86.0 132.0 85.0 84.0 154.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:1.42 (1.2%) stddev-sans-first:1.42 11:36:21 INFO - PROCESS | 17591 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 121.0 120.0 119.0 119.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 11:36:21 INFO - PROCESS | 17591 | Values: 148.0 147.0 148.0 148.0 148.0 147.0 146.0 148.0 149.0 147.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 11:36:21 INFO - PROCESS | 17591 | Values: 95.0 96.0 97.0 95.0 96.0 96.0 96.0 97.0 97.0 95.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.50 stddev:1.96 (3.3%) stddev-sans-first:2.00 11:36:21 INFO - PROCESS | 17591 | Values: 57.0 57.0 60.0 57.0 59.0 62.0 60.0 56.0 57.0 60.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:36:21 INFO - PROCESS | 17591 | Values: 62.0 62.0 62.0 61.0 62.0 61.0 61.0 62.0 61.0 61.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:5.60 (6.7%) stddev-sans-first:5.67 11:36:21 INFO - PROCESS | 17591 | Values: 79.0 85.0 86.0 85.0 81.0 81.0 81.0 82.0 98.0 79.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.00 stddev:5.73 (4.4%) stddev-sans-first:5.87 11:36:21 INFO - PROCESS | 17591 | Values: 124.0 122.0 125.0 125.0 140.0 130.0 123.0 135.0 128.0 130.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.50 stddev:3.35 (2.0%) stddev-sans-first:3.48 11:36:21 INFO - PROCESS | 17591 | Values: 167.0 165.0 169.0 170.0 164.0 166.0 161.0 167.0 162.0 160.0 11:36:21 INFO - PROCESS | 17591 | 11:36:21 INFO - PROCESS | 17591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:2.55 (3.9%) stddev-sans-first:1.72 11:36:21 INFO - PROCESS | 17591 | Values: 70.0 64.0 66.0 65.0 63.0 66.0 61.0 62.0 64.0 63.0 11:36:21 INFO - PROCESS | 17591 | -------- Summary: end -------- 11:36:21 INFO - PROCESS | 17591 | 11:36:22 INFO - TEST-INFO | 17591: exit 0 11:36:22 INFO - TEST-OK | kraken | took 62468ms 11:36:22 INFO - SUITE-END | took 1173s 11:36:22 INFO - Completed test suite (00:19:33) 11:36:22 INFO - javascript benchmark 11:36:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7226.760230639955, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.0781019599217, 3161.936761264774, 3183.9044828655133, 3186.9681303186976, 3205.4069997050533, 5453.563714902813, 5454.072807622703, 5508.724563771811, 5539.667619942807, 5553.0, 5379.919301210485, 5427.48438898305, 5432.75552600133, 5470.398256191816, 5528.5024347808685, 4858.441279252878, 4899.387576552931, 4986.5013498650205, 5047.64666473347, 5062.341895553573, 687.3134411167455, 4999.975000124994, 5051.191809310511, 5065.341505604266, 5122.743862806845, 4993.575546078588, 5014.348134742479, 5038.748062596856, 5041.04220198163, 5087.872803179913, 4945.085159245515, 5056.494350564951, 5060.645754797166, 5068.265101560253, 5073.137566613685, 4964.329815474937, 4994.375703037121, 5013.423456302536, 5016.172331565287, 5020.523050310215, 5443.727813609304, 5488.039593071197, 5489.368722596872, 5503.2020357048405, 5503.642263252876, 5709.77160913563, 5829.912551311733, 5855.209546711182, 5917.6449413034925, 5920.822375328747, 5954.4938680212235, 5979.5814292999075, 5994.07091900756, 6004.309504407005, 6016.879662406727, 5504.80733174341, 5517.724113794295, 5520.227168196456, 5555.805546805843, 5576.776928922797, 5832.008558544972, 6016.939830601726, 6030.065339872327, 6077.179580756541, 6107.84730381744, 5839.970800145972, 5846.766129354778, 5848.356680765112, 5851.590388672752, 5851.590388672752, 5939.07944268639, 5942.435468630473, 5947.613405128653, 5949.672767997802, 5952.166696662471, 5758.62568933018, 5807.245058142415, 5815.9709201453725, 5869.090291004901, 5899.46904778572, 5766.163906233656, 5792.420757924174, 5830.47525722687, 5852.619579727304, 5874.089516125007, 4508.391367165456, 4510.864674059783, 4515.119551687455, 4516.458025036951, 4560.794764235618, 3960.7623542587535, 3973.0266084809405, 3987.2424239395004, 4022.6982976276895, 4029.1941611677194, 5587.804426845041, 5614.8489559640175, 5662.886742265214, 5677.17680936262, 5678.004444952721, 5756.194132821408, 5941.079132734433, 5974.880502389928, 5974.970125149433, 5989.55078369124, 5566.165075238666, 5578.804741834017, 5582.0789569721355, 5607.102863541813, 5643.858903527363, 5097.566706829887, 5111.309973153651, 5123.052235336475, 5133.101707201225, 5156.510131537498, 5932.961731696936, 6056.636601803906, 6077.787277445268, 6113.32753397126, 6135.355787642323, 5924.289085309877, 5970.731317090655, 5982.581219314607, 5993.730282137401, 6003.129546215687, 6156.015037593964, 6181.443670069535, 6186.257649082139, 6189.84525386869, 6191.349908259748, 5669.092945128759, 5765.250517432707, 5779.7110144493445, 5886.381929897299, 5908.379620139824, 5919.822405327847, 5942.168096466412, 5945.64326140433, 5947.286325640778, 5980.671063091571, 5764.423557644202, 5794.18881356602, 5800.332961709289, 5809.2738407699035, 5811.854703632443, 5598.804041858515, 5673.3759286477625, 5688.11834165705, 5763.5965482417505, 5773.422657734361, 5543.805966791143, 5669.971650141723, 5673.602847800779, 5680.233168522197, 5701.7434215461235, 5824.621399609012, 5850.765969361178, 5855.3266374367495, 5869.090291004901, 5871.4715675589405, 5557.527610153021, 5635.6618602883955, 5681.431856814285, 5704.971475142764, 5725.398833122462], "value": 5410.250340339992, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.1114528054156, 615.9507239420847, 621.1676353686059, 639.2584601861842, 646.7768619826161, 40999.38500922485, 42644.78677606612, 42707.359389609104, 42818.0, 46107.07785844281, 44000.55999440005, 44467.11065778683, 44487.77756111223, 44688.106237875225, 44689.0, 8869.60086796094, 9007.864882026775, 9019.774505637379, 9036.277097832157, 9039.728808135766, 8842.381033327669, 8880.378373513857, 8958.552072396387, 8975.865362019542, 9002.369834111614, 8984.371094023421, 9009.0, 9050.502222377767, 9059.184673379394, 9075.818483630323, 8781.64873405063, 8892.0, 8896.51069191191, 8913.465192088495, 8979.10208979097, 8987.46075235488, 9039.457632542002, 9058.411203271831, 9083.954580227057, 9084.0, 41799.1640167198, 42071.0, 42246.57753422457, 42296.57703422957, 42465.57534424647, 3082.9845850770603, 3378.814165220912, 3477.165480284739, 3641.253543023674, 3735.6077611850637, 32158.0, 33032.0, 33339.83330083358, 33469.330613387836, 34359.0, 4354.0, 4367.627817784111, 4386.013147041922, 4409.184300904343, 4437.6923999520395, 351411.0, 352894.0, 353399.2330038359, 355677.0, 357554.0, 34356.0, 53993.46006539963, 54033.729831351375, 54340.18489722657, 54502.0, 34147.14632134167, 36175.27649447049, 36454.27091458209, 36597.817010914776, 36711.816440918155, 15163.469278575198, 15458.38166473351, 15480.303386347641, 15550.222488875512, 15600.843991560167, 13355.799663005062, 13451.461941522426, 13468.191908485327, 13479.595612131652, 13510.662233444045, 8303.626336814857, 8328.250457458858, 8378.748637540884, 8406.705765298308, 8425.83148337042, 3191.2181515528846, 3218.6942240487115, 3280.6391296957318, 3280.9015729527673, 3285.7535684823733, 970.0784254957819, 979.7942432089341, 995.1690338567232, 1000.2548101664162, 1052.1109662335314, 31911.52132718011, 32743.0, 32771.34457310888, 32902.177445564055, 32951.50572741411, 1069.187417562658, 1124.145649306533, 1126.3410904620725, 1132.6432173865205, 1154.4112502623723, 16598.41905533325, 16932.830671693126, 16968.15159242033, 17162.914185428992, 17587.29650813953, 518438.0, 518465.0, 518869.0, 521769.0, 524029.0, 57866.0, 58280.0, 58375.12437313444, 58430.70784646049, 58439.0, 1326.5622344626443, 1338.5716570697477, 1354.8145372798997, 1358.9660258493418, 1360.1363134409721, 29826.85086574553, 30845.845770771004, 31558.211044724067, 31584.0, 32126.678733212368, 49910.75044624753, 54023.729881350344, 56128.0, 56498.0, 60048.39951600603, 469347.0, 472421.0, 475072.0, 476025.0, 478196.0, 44023.339649905916, 44271.0, 44475.0, 44835.77582112069, 45521.544784551734, 48715.5128448711, 49232.261516078004, 49420.0, 50084.0, 50717.23924141215, 41435.585644143175, 41960.0, 42101.36847947222, 42279.788601056796, 42685.57314426816, 40832.0, 41315.380269296584, 42143.57856421397, 42722.57277427186, 43034.78482607567, 41110.588894110675, 41807.581924181584, 41857.0, 42164.578354216064, 42214.0, 35462.82268588641, 37271.62728372682, 37750.811245943594, 38321.80839095786, 38465.42301865418, 28263.576046359733, 28687.282817929718, 28851.71148288574, 28869.711302886702, 29154.708452915198], "value": 19321.54941474, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.58754894909316, 402.42855145693113, 403.5097356711595, 404.8400881651748, 413.60522574294833, 13737.519186828464, 18074.457766267, 18948.336808211716, 19554.511137221576, 19728.01359932003, 18899.24403023881, 18901.905490472564, 19352.419427417164, 19561.41315760526, 19716.408507744756, 5316.0962636351915, 5578.9163162552595, 5610.551155907538, 5611.046122159243, 5816.1275808628625, 5195.246689230059, 5525.336959564858, 5638.210650508932, 5651.886962260753, 5689.146628005811, 5564.054110801153, 5572.7770889164385, 5580.944190558103, 5590.944090559083, 5595.916061259084, 5672.659640421567, 5701.515371193454, 5751.0, 5761.9916514610195, 5770.019096753541, 5403.729813509309, 5557.166425036236, 5568.693721845297, 5576.693281869496, 5592.412796656374, 13843.792343114861, 13846.446142154302, 13848.307584620728, 18587.0, 22387.10451581935, 2310.560993411263, 2450.3751543356507, 2620.2139358192658, 2725.2914242296947, 2969.539721343195, 10163.390196588154, 10187.745306367326, 10228.89771102287, 10313.48432578368, 10642.0, 1898.5538398476347, 1960.7156962240538, 1964.1161477335256, 1967.8425725942034, 2008.9296874609465, 79926.20073799246, 80647.0, 82539.58730206371, 84072.0, 85030.14969850284, 10603.41681207541, 10828.133749300037, 10843.969822866815, 10976.286541374786, 11202.103831693445, 15022.0, 15024.474143404928, 15025.474108406153, 15230.238488075773, 15245.23773811305, 7981.72063977758, 8370.497770133812, 8494.362922780816, 8532.70135545253, 8547.316214702809, 7719.838445235343, 7749.8450030999065, 7886.487378320506, 7906.723264685708, 7936.0, 4644.303354496852, 4759.405074365704, 4790.688605240648, 4792.376990991149, 4859.538343857328, 1921.1834970137636, 1937.5834195648004, 1972.477293517219, 1991.084101313412, 2053.7638171610156, 839.3117643532368, 911.5487833522449, 950.3442624589012, 982.749398903275, 994.5176589354157, 17736.822631773517, 18792.248310067444, 19348.805745948768, 19524.12141453638, 19844.404667859988, 944.2021491839384, 962.855571664242, 1004.9598016079422, 1024.155072065549, 1057.7672911959357, 10395.740106497247, 10631.681049568526, 10925.235233533576, 11051.834222486668, 11218.214724969173, 455371.0, 456829.0, 459755.0, 461754.0, 466371.0, 79387.0, 90488.54755726179, 92418.0, 93866.53066734623, 95047.0, 1017.1100287248657, 1051.7475805806705, 1052.768390953989, 1064.6539874540806, 1065.760203954104, 17201.397951072155, 17389.91305043467, 17455.476335709947, 17578.12109394551, 17877.195526201092, 32839.01482955515, 40958.59041409667, 41271.380929285486, 41312.38031429471, 42833.35749963815, 55215.17177242425, 56515.71742141263, 56880.146797798894, 57424.425755741904, 57813.4218657808, 7479.476436649382, 7750.10873749526, 7841.686332546634, 8455.66177352899, 8812.030676625438, 9211.76970575741, 12353.505859765508, 13446.260455675032, 13676.863231367957, 14110.788338175142, 11835.28988260707, 11883.108766842348, 12109.515619375126, 12313.507459701512, 12338.444769985552, 12033.819492707791, 12073.39633018328, 12126.0, 12224.388780561114, 12321.568745093879, 10762.19283553721, 10792.730181745519, 11914.0, 12008.519659213534, 12607.369631518572, 7422.888656670262, 7847.568383738949, 7847.646855891385, 8693.39146259781, 8965.955170224108, 8910.108989101298, 10786.838197427202, 10894.400807955639, 11223.102151827998, 11468.65594032147], "value": 9058.34385192646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.167095590991, 1480.097140744146, 1596.1221328269448, 1709.640975395167, 1751.7197248440252, 7904.683812647487, 8382.497050176993, 8566.143385661439, 9068.3198760093, 9082.364234503579, 8518.148185181479, 8714.694985675487, 8718.651253949834, 8775.6050977706, 8808.735737927873, 2314.849534780238, 2343.5547246023284, 2352.4706940938236, 2353.9411514712183, 2361.7756313150308, 2302.9309120726407, 2317.1889838556453, 2334.6381310896754, 2340.32130682102, 2351.1888398502488, 2298.390926404504, 2301.1945818963395, 2333.9533209335805, 2341.7424083350816, 2348.5655153796515, 2273.954520909581, 2274.9090036398525, 2290.7365652949957, 2311.05246848792, 2312.109837712476, 2301.5396920615945, 2319.93040208794, 2331.4754180309465, 2333.57995560799, 2333.94165145871, 8835.514046727427, 8924.330675199386, 8924.509151996637, 8932.419392739452, 8939.374243802937, 5213.7393130343335, 5300.496452836975, 5347.438518955531, 5353.9196912046355, 5360.088784906575, 3219.8551065201887, 3297.686719761619, 3372.532948167555, 3437.3125374925116, 3454.6890779829687, 1110.0453609895483, 1126.7126882644955, 1127.932324060559, 1150.8331291962702, 1175.870654228043, 12172.513099476011, 12255.69360765979, 12273.324967126804, 12295.385230738517, 12327.568535101318, 4390.165868485042, 4437.489688685778, 4562.1560011398, 4564.726116432958, 4573.977130114328, 10424.218183636258, 10472.266941314036, 10487.161027117812, 10526.789464210826, 10532.736681583021, 5187.507186817246, 5213.087709650796, 5226.477352264743, 5247.212918062245, 5247.553957913544, 4229.45017147775, 4696.459907110658, 4708.576228139484, 4817.542333478314, 4844.491328410466, 3874.535055793323, 3921.9019524512114, 3936.527616686016, 3992.6007399259843, 4001.4397984282223, 1244.1415423357855, 1247.0857234145542, 1248.7190382164122, 1269.6127681057183, 1299.402274953532, 777.1218523069009, 879.2658130461009, 913.3925939250324, 974.9415035097917, 993.7764003099245, 6009.699515024231, 6119.602225855305, 6165.907511387333, 6280.340564240781, 6476.805695829133, 951.5813042261383, 952.9237660987104, 996.5465713100522, 1016.6086056868158, 1019.918406527476, 4144.91710165795, 4278.786060697015, 4321.395004699345, 4373.540778218305, 4373.650107991353, 11012.834807477895, 11184.44077796107, 11305.773884522428, 11325.32048077118, 11338.09295256394, 10239.283250172566, 10622.20333474977, 11234.943825280821, 11247.943760281147, 11266.718332041764, 8102.0, 8259.42184047111, 8264.090949995616, 8294.170582941779, 8317.750467485985, 6169.598976066542, 6243.906341404973, 6433.903491447726, 6442.065900444316, 6455.548111632141, 10200.795984080425, 10221.0, 10257.33327333721, 10294.176465882561, 10356.844647330145, 10243.539040743333, 10585.682429527127, 10592.258541901992, 10652.147828173573, 10719.624813131502, 7275.126984761862, 7493.737719179802, 7759.340456061298, 7773.222677732181, 7958.602069896367, 8742.956285218534, 8762.693305734269, 8792.956035219782, 8814.647414103363, 8852.291816654524, 7676.0, 7794.883076753967, 7903.802404939923, 7946.8807967879375, 7984.840303193788, 7345.742898998509, 7744.57404842739, 7790.766277011699, 7871.606419679108, 7908.169642187488, 7040.683169257293, 7160.892586611101, 7222.349988501061, 7245.5652660840515, 7252.637368131678, 5321.866953326198, 5331.546818520469, 5454.4272851351625, 5465.016297066407, 5493.2034854946605, 5148.845534633967, 5355.812546560852, 5361.437049109787, 5362.605722512097, 5396.1366181410785], "value": 4690.708935975405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3273126434487, 324.2736270753512, 328.985195666195, 331.19684764446225, 336.94103531881916, 5574.888502229953, 5618.438156184385, 5637.915431268534, 5639.6334238274485, 5674.177244299574, 5558.416366281533, 5569.721513924308, 5577.191307260455, 5601.439856014396, 5619.971900140504, 4139.3583994480905, 4150.43969064177, 4243.72415792974, 4251.171021650779, 4265.658747300224, 4246.766427846467, 4262.318029115342, 4265.957340426603, 4278.315469524877, 4298.978505107486, 4255.680823938202, 4269.402283680287, 4286.0, 4292.248856450125, 4295.892602684927, 4020.155767288873, 4236.406903033578, 4245.1934132514725, 4259.488861336628, 4288.292431748758, 3662.4872517847257, 3702.6118153790653, 3703.5000274962804, 3716.089558058266, 3741.3639681254253, 5357.223202635596, 5413.64811287269, 5414.835810300765, 5419.34967803866, 5453.3728621208675, 4723.645726570487, 4922.778474968635, 4937.456879743226, 4940.407151141886, 4959.256111583255, 5883.17635531026, 5903.321118071433, 5903.439173278532, 5908.911366329508, 5910.083936989773, 4107.938380924288, 4117.691173161995, 4119.176164767058, 4141.875743727693, 4161.8959526012095, 5915.438033386865, 6090.086487026982, 6113.32753397126, 6130.356312587203, 6157.938420615781, 4165.937510937339, 4185.832566697298, 4202.432671589358, 4231.555686652919, 4249.490061192615, 4270.829166833292, 4287.356896465555, 4289.528151903288, 4303.892402689958, 4307.870763877088, 4650.186217412007, 4914.574773315699, 4919.1883339248625, 4960.528749768766, 4963.60291176705, 5882.058870580687, 5882.323532793698, 5905.1142328650185, 5906.763729450774, 5925.970370148208, 1465.5456808389433, 1472.85271472854, 1481.5555333399936, 1487.8171853376375, 1488.8064551608222, 941.8869735631768, 961.6538046303325, 968.7287559483356, 996.5266498413196, 1012.9290949633455, 5603.6077474577205, 5666.858328541737, 5678.432156784371, 5685.317761868602, 5713.942860571424, 5976.193213916153, 5995.730192141364, 5998.790042348497, 6009.879802403927, 6073.908891366633, 5392.784288628411, 5633.746481408347, 5681.914771278434, 5701.543876489954, 5712.428757124254, 3173.1591128351006, 3204.919877003047, 3205.406999705062, 3206.8556914938886, 3221.194701324669, 6126.079309242089, 6143.232095988002, 6215.595986260879, 6266.780662676784, 6268.529860260499, 6134.723937422827, 6143.293521245025, 6154.846128846814, 6225.443639090227, 6250.343713910065, 6116.418940200674, 6233.875322493524, 6236.875262494725, 6284.497240220771, 6294.590851594632, 6057.909131362945, 6076.693510895002, 6077.756889724362, 6077.969610152098, 6100.908486372797, 5988.0, 5999.760009599567, 6081.787137450168, 6122.510199184144, 6144.170536977451, 5913.822585322448, 6169.444749972524, 6235.314115447388, 6282.465990390868, 6316.0, 4162.62633330994, 4168.4997800262945, 4172.497900755786, 4190.580941905785, 4204.558521355214, 5843.211166492469, 5948.583599148191, 6065.8474889770805, 6091.177691011657, 6119.173911521888, 5903.350631430453, 5932.940670593239, 5964.582479226413, 5968.582199246011, 5970.313413957277, 5833.562482813721, 5896.49879760208, 5945.227120474311, 5965.880682386415, 5982.371850955761, 5586.273784408001, 5779.393163717918, 5790.536757059341, 5808.605934575756, 5868.474196708972, 5896.292444906639, 5970.00004998313, 5975.028240680652, 5988.910166347596, 6012.549058820693, 5677.971610141923, 5747.476918616487, 5759.51044161251, 5816.371416003526, 5860.501857342003], "value": 4448.111216096963, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9046733457317, 757.2919320435393, 800.1718221640604, 800.2277801921141, 822.9958850205749, 15315.310811013504, 16621.41825036124, 16634.916825415887, 16673.333066677333, 16786.832131678693, 15004.0, 15070.17114058729, 15198.620034499143, 15205.54383368498, 15227.0, 658.6410406328563, 773.5358784729174, 782.3701919954434, 790.3479629305817, 792.3621484704839, 779.9961000195019, 783.7883771381723, 785.0618510879501, 786.6027656033724, 791.2759824760337, 850.9872351914695, 855.7218903856271, 855.7603870916154, 855.9058503564634, 856.1866227084295, 848.5799529233008, 849.0617867256716, 849.3757088539949, 851.5231470376578, 852.6930305090162, 614.2383444528753, 618.5917294585597, 619.2414292491707, 619.2970977940025, 623.4949690750507, 14547.70904581913, 14617.269136543131, 14622.415103395851, 14629.0, 14698.485553005594, 14820.481283155146, 15053.623659408602, 15320.693586128327, 15347.309371078216, 15544.844551554454, 11640.66132394777, 11714.117279883503, 12037.578684745991, 12052.879471205264, 12433.005359571212, 4332.891677708051, 4367.0, 4398.164348773723, 4409.140217657558, 4457.398251236074, 77294.61352693258, 77570.0, 77834.0, 78232.0, 79806.6009669948, 10929.890701092887, 10934.945325273322, 10956.616518421817, 10969.122470202365, 10981.670549883516, 19863.900680496794, 19953.700694489595, 20000.59998800045, 20019.199232030554, 20052.097655605532, 8117.188281171953, 8175.427720059658, 8252.05101413345, 8351.24838764514, 8378.455400398954, 4655.649861540183, 4719.858404247878, 4777.307290442866, 4803.207470767354, 4935.62982776286, 3442.5008373785663, 3541.9291614167573, 3542.220711443478, 3544.8759293424605, 3550.8757193498104, 635.4979566142788, 637.9043143528415, 645.9967700161563, 649.1074772188241, 649.2857856357969, 505.29511331692083, 559.6362364463132, 604.9001914684028, 652.9934700652933, 673.8416472129046, 8718.738437846874, 8784.822765851222, 8911.55442227886, 8990.55047247635, 9136.314776391797, 620.7020630097578, 673.6934694713893, 680.2041611314773, 693.2859155070286, 717.9820504487429, 4349.478062632441, 4419.226635338803, 4438.334249862546, 4493.707908985905, 4505.301678239878, 66661.6666916672, 67206.66396668083, 67315.32684673091, 67414.3258567408, 106367.93632063735, 60993.0, 63421.36578634247, 67412.0, 84353.0, 101427.49286253522, 77778.61110694411, 78487.0, 88604.556977216, 88995.11004889868, 92083.0, 8244.381671374791, 8315.916840831756, 8355.45689530203, 8452.704155354533, 8613.526256055977, 49742.0, 51766.0, 51879.22181167361, 52457.47542524526, 53674.46325536851, 57803.71098144651, 74742.0, 75618.0, 76280.61859690888, 76331.0, 11324.660260192208, 11502.252353596989, 11607.129465289969, 11772.941135294268, 11781.352025638329, 12317.815232771336, 12605.936970315457, 12869.678258043623, 12881.48474061027, 12893.0, 11543.365114918424, 11973.161878668758, 12157.513699452276, 12192.57325993586, 12243.510259589517, 11444.198906076495, 11528.0, 11579.13156513248, 11591.304521728724, 11789.0, 11404.429778511207, 11565.421728913689, 11915.165938384576, 13043.413046413123, 13049.478020879058, 10908.2364234506, 11162.944185279346, 11273.267237629529, 11761.294322340687, 12127.664867285186, 11492.0, 11700.88299117032, 11834.76330473403, 11905.82141267899, 11954.342511161969], "value": 7209.399075823379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 110.0, 111.0, 109.0, 112.0, 110.0, 110.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 152.0, 182.0, 142.0, 150.0, 154.0, 133.0, 188.0, 126.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 165.0, 173.0, 164.0, 163.0, 162.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 76.0, 76.0, 162.0, 75.0, 75.0, 75.0, 75.0, 164.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 154.0, 84.0, 85.0, 86.0, 132.0, 85.0, 84.0, 154.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 121.0, 120.0, 119.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 146.0, 148.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 60.0, 57.0, 59.0, 62.0, 60.0, 56.0, 57.0, 60.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 86.0, 85.0, 81.0, 81.0, 81.0, 82.0, 98.0, 79.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 125.0, 125.0, 140.0, 130.0, 123.0, 135.0, 128.0, 130.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 169.0, 170.0, 164.0, 166.0, 161.0, 167.0, 162.0, 160.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 66.0, 65.0, 63.0, 66.0, 61.0, 62.0, 64.0, 63.0], "value": 64.4, "unit": "score"}]}]} 11:36:22 INFO - Return code: 0 11:36:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:22 ERROR - # TBPL SUCCESS # 11:36:22 INFO - Running post-action listener: _resource_record_post_action 11:36:22 INFO - ##### 11:36:22 INFO - ##### Finished run-tests step (success) 11:36:22 INFO - ##### 11:36:22 INFO - Running post-run listener: _resource_record_post_run 11:36:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552767488; Read time: 8; Write time: 492884 11:36:22 INFO - TinderboxPrint: CPU usage
13.4% 11:36:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:36:22 INFO - TinderboxPrint: I/O write bytes / time
552,767,488 / 492,884 11:36:22 INFO - TinderboxPrint: CPU idle
8,226.1 (86.6%) 11:36:22 INFO - TinderboxPrint: CPU user
1,216.2 (12.8%) 11:36:22 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257179648; Read time: 0; Write time: 291736 11:36:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295587840; Read time: 8; Write time: 201148 11:36:22 INFO - Running post-run listener: _upload_blobber_files 11:36:22 INFO - Blob upload gear active. 11:36:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:22 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 11:36:22 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:36:22 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:36:23 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:24 INFO - (blobuploader) - INFO - Done attempting. 11:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:24 INFO - (blobuploader) - INFO - Done attempting. 11:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:28 INFO - (blobuploader) - INFO - Done attempting. 11:36:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:28 INFO - Return code: 0 11:36:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562f98a4b2b3bb0204e8fb684dfd261671313ce9a0071a0fd047de811bbbd837eecd2020b0b3e044a6aecef9ecdff4806cfa43fcdb147c6a4a72f3e9311cee39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cf13ee23bc780ed60a366fb3be8660ff15134bedff4b2306d7e509041285aeedb2638713d826cf46224f82b8f786b577fb28b7621c8091b00f2a2ede08b2fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4643bb3975e4cca414274a561b27e99f49ceecf987049a2adeaa4df5ac37c109212d98ecaed7055b7ccb7611e81840879b045f4c4ed6363ebe964a905e9a21"} 11:36:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:28 INFO - Contents: 11:36:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/562f98a4b2b3bb0204e8fb684dfd261671313ce9a0071a0fd047de811bbbd837eecd2020b0b3e044a6aecef9ecdff4806cfa43fcdb147c6a4a72f3e9311cee39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cf13ee23bc780ed60a366fb3be8660ff15134bedff4b2306d7e509041285aeedb2638713d826cf46224f82b8f786b577fb28b7621c8091b00f2a2ede08b2fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4643bb3975e4cca414274a561b27e99f49ceecf987049a2adeaa4df5ac37c109212d98ecaed7055b7ccb7611e81840879b045f4c4ed6363ebe964a905e9a21"} 11:36:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:28 INFO - Copying logs to upload dir... 11:36:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.489984 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-23 11:36:28.138987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:28.146811) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 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/Fx-Team/sha512/562f98a4b2b3bb0204e8fb684dfd261671313ce9a0071a0fd047de811bbbd837eecd2020b0b3e044a6aecef9ecdff4806cfa43fcdb147c6a4a72f3e9311cee39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cf13ee23bc780ed60a366fb3be8660ff15134bedff4b2306d7e509041285aeedb2638713d826cf46224f82b8f786b577fb28b7621c8091b00f2a2ede08b2fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4643bb3975e4cca414274a561b27e99f49ceecf987049a2adeaa4df5ac37c109212d98ecaed7055b7ccb7611e81840879b045f4c4ed6363ebe964a905e9a21"} build_url:https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/YQ1D1MbORJu1k_1TWMhwpQ/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/Fx-Team/sha512/562f98a4b2b3bb0204e8fb684dfd261671313ce9a0071a0fd047de811bbbd837eecd2020b0b3e044a6aecef9ecdff4806cfa43fcdb147c6a4a72f3e9311cee39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cf13ee23bc780ed60a366fb3be8660ff15134bedff4b2306d7e509041285aeedb2638713d826cf46224f82b8f786b577fb28b7621c8091b00f2a2ede08b2fe8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b4643bb3975e4cca414274a561b27e99f49ceecf987049a2adeaa4df5ac37c109212d98ecaed7055b7ccb7611e81840879b045f4c4ed6363ebe964a905e9a21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:28.180872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:28.181458) ========= 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=652eb03db935cfc1c15ebda0000001ad-1466703684.31114-290115804 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 11:36:28.263133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:36:28.263444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 11:36:28.263757) ========= ========= Total master_lag: 0.23 =========