builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1465417919.05 results: success (0) buildid: 20160608123529 builduid: 31d383f76b374accaf30f473c7fca2cb revision: 4c902c5433c7c10b07b302ec856b4789a2fef65d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.054303) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.055004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.055457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.080353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.080791) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 13:31:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.5M=0s 2016-06-08 13:31:59 (28.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102272 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.208346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.208669) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.127561 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:31:59.347085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 13:31:59.347667) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c902c5433c7c10b07b302ec856b4789a2fef65d --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 4c902c5433c7c10b07b302ec856b4789a2fef65d --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=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 13:31:59,739 truncating revision to first 12 chars 2016-06-08 13:31:59,739 Setting DEBUG logging. 2016-06-08 13:31:59,739 attempt 1/10 2016-06-08 13:31:59,739 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c902c5433c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 13:32:00,729 unpacking tar archive at: fx-team-4c902c5433c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.343671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 13:32:00.706248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 13:32:00.706781) ========= script_repo_revision: 4c902c5433c7c10b07b302ec856b4789a2fef65d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 13:32:00.707420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 13:32:00.707876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 13:32:00.718766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-08 13:32:00.719129) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:32:01 INFO - MultiFileLogger online at 20160608 13:32:01 in /builds/slave/test 13:32:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:32:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:01 INFO - {'append_to_log': False, 13:32:01 INFO - 'base_work_dir': '/builds/slave/test', 13:32:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:32:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:01 INFO - 'branch': 'Fx-Team-Non-PGO', 13:32:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:01 INFO - 'config_files': ('talos/linux_config.py',), 13:32:01 INFO - 'default_actions': ('clobber', 13:32:01 INFO - 'read-buildbot-config', 13:32:01 INFO - 'download-and-extract', 13:32:01 INFO - 'populate-webroot', 13:32:01 INFO - 'create-virtualenv', 13:32:01 INFO - 'install', 13:32:01 INFO - 'run-tests'), 13:32:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:01 INFO - 'download_minidump_stackwalk': True, 13:32:01 INFO - 'download_symbols': 'ondemand', 13:32:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:01 INFO - 'installer_path': 'installer.exe', 13:32:01 INFO - 'log_level': 'info', 13:32:01 INFO - 'log_name': 'talos', 13:32:01 INFO - 'log_to_console': True, 13:32:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:32:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:32:01 INFO - 'opt_config_files': (), 13:32:01 INFO - 'pip_index': False, 13:32:01 INFO - 'sps_profile': False, 13:32:01 INFO - 'sps_profile_interval': 0, 13:32:01 INFO - 'suite': 'dromaeojs', 13:32:01 INFO - 'system_bits': '32', 13:32:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:01 INFO - 'title': 'talos-linux64-ix-001', 13:32:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:01 INFO - 'use_talos_json': True, 13:32:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:01 INFO - 'work_dir': 'build'} 13:32:01 INFO - ##### 13:32:01 INFO - ##### Running clobber step. 13:32:01 INFO - ##### 13:32:01 INFO - Running pre-action listener: _resource_record_pre_action 13:32:01 INFO - Running main action method: clobber 13:32:01 INFO - rmtree: /builds/slave/test/build 13:32:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:05 INFO - Running post-action listener: _resource_record_post_action 13:32:05 INFO - ##### 13:32:05 INFO - ##### Finished clobber step (success) 13:32:05 INFO - ##### 13:32:05 INFO - ##### 13:32:05 INFO - ##### Running read-buildbot-config step. 13:32:05 INFO - ##### 13:32:05 INFO - Running pre-action listener: _resource_record_pre_action 13:32:05 INFO - Running main action method: read_buildbot_config 13:32:05 INFO - Using buildbot properties: 13:32:05 INFO - { 13:32:05 INFO - "project": "", 13:32:05 INFO - "product": "firefox", 13:32:05 INFO - "script_repo_revision": "production", 13:32:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:32:05 INFO - "repository": "", 13:32:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:32:05 INFO - "buildid": "20160608123529", 13:32:05 INFO - "pgo_build": "False", 13:32:05 INFO - "basedir": "/builds/slave/test", 13:32:05 INFO - "buildnumber": 3067, 13:32:05 INFO - "slavename": "talos-linux64-ix-001", 13:32:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:32:05 INFO - "platform": "ubuntu64_hw", 13:32:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:32:05 INFO - "branch": "fx-team", 13:32:05 INFO - "repo_path": "integration/fx-team", 13:32:05 INFO - "revision": "4c902c5433c7c10b07b302ec856b4789a2fef65d", 13:32:05 INFO - "stage_platform": "linux64", 13:32:05 INFO - "builduid": "31d383f76b374accaf30f473c7fca2cb", 13:32:05 INFO - "slavebuilddir": "test" 13:32:05 INFO - } 13:32:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:32:05 INFO - Running post-action listener: _resource_record_post_action 13:32:05 INFO - ##### 13:32:05 INFO - ##### Finished read-buildbot-config step (success) 13:32:05 INFO - ##### 13:32:05 INFO - ##### 13:32:05 INFO - ##### Running download-and-extract step. 13:32:05 INFO - ##### 13:32:05 INFO - Running pre-action listener: _resource_record_pre_action 13:32:05 INFO - Running main action method: download_and_extract 13:32:05 INFO - mkdir: /builds/slave/test/build/tests 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:32:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:06 INFO - Downloaded 1361 bytes. 13:32:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:32:06 INFO - Using the following test package requirements: 13:32:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:32:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:32:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'jsshell-linux-x86_64.zip'], 13:32:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:32:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:32:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:32:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:32:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:32:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:32:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:32:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:06 INFO - https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:07 INFO - Downloaded 22878253 bytes. 13:32:07 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'] 13:32:07 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 13:32:09 INFO - Return code: 0 13:32:09 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 13:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:09 INFO - https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:11 INFO - Downloaded 22878253 bytes. 13:32:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:32:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:32:12 INFO - Return code: 0 13:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:12 INFO - https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:14 INFO - Downloaded 10833369 bytes. 13:32:14 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'] 13:32:14 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 13:32:15 INFO - Return code: 0 13:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:15 INFO - https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fkOzrWE8RoCShVvsMkdEhw/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 13:32:16 INFO - Downloaded 55367981 bytes. 13:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:16 INFO - mkdir: /builds/slave/test/properties 13:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:16 INFO - Contents: 13:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:32:17 INFO - Running post-action listener: _resource_record_post_action 13:32:17 INFO - Running post-action listener: set_extra_try_arguments 13:32:17 INFO - ##### 13:32:17 INFO - ##### Finished download-and-extract step (success) 13:32:17 INFO - ##### 13:32:17 INFO - ##### 13:32:17 INFO - ##### Running populate-webroot step. 13:32:17 INFO - ##### 13:32:17 INFO - Running pre-action listener: _resource_record_pre_action 13:32:17 INFO - Running main action method: populate_webroot 13:32:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:17 INFO - '--tppagecycles', 13:32:17 INFO - '7'], 13:32:17 INFO - 'tests': ['tsvgm']}}, 13:32:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:32:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:32:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:32:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['damp', 'tps']}, 13:32:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'tests': ['damp', 'tps']}, 13:32:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['dromaeo_dom']}, 13:32:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['a11yr', 13:32:17 INFO - 'ts_paint', 13:32:17 INFO - 'tpaint', 13:32:17 INFO - 'sessionrestore', 13:32:17 INFO - 'sessionrestore_no_auto_restore', 13:32:17 INFO - 'tabpaint']}, 13:32:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['tsvgx', 13:32:17 INFO - 'tsvgr_opacity', 13:32:17 INFO - 'tart', 13:32:17 INFO - 'tscrollx', 13:32:17 INFO - 'cart']}, 13:32:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:32:17 INFO - 'tsvgr_opacity', 13:32:17 INFO - 'tart', 13:32:17 INFO - 'tscrollx', 13:32:17 INFO - 'cart']}, 13:32:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'talos_options': ['--disable-e10s'], 13:32:17 INFO - 'tests': ['tp5o']}, 13:32:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'tests': ['tp5o']}, 13:32:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'talos_options': ['--disable-e10s', 13:32:17 INFO - '--xperf_path', 13:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:17 INFO - 'tests': ['tp5n']}, 13:32:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:17 INFO - 'talos_options': ['--xperf_path', 13:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:17 INFO - 'tests': ['tp5n']}}, 13:32:17 INFO - 'talos.zip': {'path': '', 13:32:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:17 INFO - Running post-action listener: _resource_record_post_action 13:32:17 INFO - ##### 13:32:17 INFO - ##### Finished populate-webroot step (success) 13:32:17 INFO - ##### 13:32:17 INFO - ##### 13:32:17 INFO - ##### Running create-virtualenv step. 13:32:17 INFO - ##### 13:32:17 INFO - Running pre-action listener: _resource_record_pre_action 13:32:17 INFO - Running main action method: create_virtualenv 13:32:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:32:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:17 INFO - Using real prefix '/usr' 13:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:21 INFO - Installing pip.................done. 13:32:21 INFO - Return code: 0 13:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:32:21 INFO - Using env: {'DISPLAY': ':0', 13:32:21 INFO - 'HOME': '/home/cltbld', 13:32:21 INFO - 'LANG': 'en_US.UTF-8', 13:32:21 INFO - 'LANGUAGE': 'en_US:en', 13:32:21 INFO - 'LOGNAME': 'cltbld', 13:32:21 INFO - 'MAIL': '/var/mail/cltbld', 13:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:21 INFO - 'MOZ_NO_REMOTE': '1', 13:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:21 INFO - 'NO_EM_RESTART': '1', 13:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:21 INFO - 'PWD': '/builds/slave/test', 13:32:21 INFO - 'SHELL': '/bin/bash', 13:32:21 INFO - 'SHLVL': '1', 13:32:21 INFO - 'TERM': 'linux', 13:32:21 INFO - 'TMOUT': '86400', 13:32:21 INFO - 'USER': 'cltbld', 13:32:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:21 INFO - '_': '/tools/buildbot/bin/python'} 13:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:32:21 INFO - Cleaning up... 13:32:21 INFO - Return code: 0 13:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:32:21 INFO - Using env: {'DISPLAY': ':0', 13:32:21 INFO - 'HOME': '/home/cltbld', 13:32:21 INFO - 'LANG': 'en_US.UTF-8', 13:32:21 INFO - 'LANGUAGE': 'en_US:en', 13:32:21 INFO - 'LOGNAME': 'cltbld', 13:32:21 INFO - 'MAIL': '/var/mail/cltbld', 13:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:21 INFO - 'MOZ_NO_REMOTE': '1', 13:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:21 INFO - 'NO_EM_RESTART': '1', 13:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:21 INFO - 'PWD': '/builds/slave/test', 13:32:21 INFO - 'SHELL': '/bin/bash', 13:32:21 INFO - 'SHLVL': '1', 13:32:21 INFO - 'TERM': 'linux', 13:32:21 INFO - 'TMOUT': '86400', 13:32:21 INFO - 'USER': 'cltbld', 13:32:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:21 INFO - '_': '/tools/buildbot/bin/python'} 13:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:21 INFO - Downloading/unpacking psutil>=3.1.1 13:32:21 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 13:32:21 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 13:32:21 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 13:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:24 INFO - Installing collected packages: psutil 13:32:24 INFO - Running setup.py install for psutil 13:32:24 INFO - building 'psutil._psutil_linux' extension 13:32:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:32:25 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 13:32:25 INFO - building 'psutil._psutil_posix' extension 13:32:25 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 13:32:25 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 13:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:25 INFO - Successfully installed psutil 13:32:25 INFO - Cleaning up... 13:32:25 INFO - Return code: 0 13:32:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:32:25 INFO - Using env: {'DISPLAY': ':0', 13:32:25 INFO - 'HOME': '/home/cltbld', 13:32:25 INFO - 'LANG': 'en_US.UTF-8', 13:32:25 INFO - 'LANGUAGE': 'en_US:en', 13:32:25 INFO - 'LOGNAME': 'cltbld', 13:32:25 INFO - 'MAIL': '/var/mail/cltbld', 13:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:25 INFO - 'MOZ_NO_REMOTE': '1', 13:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:25 INFO - 'NO_EM_RESTART': '1', 13:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:25 INFO - 'PWD': '/builds/slave/test', 13:32:25 INFO - 'SHELL': '/bin/bash', 13:32:25 INFO - 'SHLVL': '1', 13:32:25 INFO - 'TERM': 'linux', 13:32:25 INFO - 'TMOUT': '86400', 13:32:25 INFO - 'USER': 'cltbld', 13:32:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:25 INFO - '_': '/tools/buildbot/bin/python'} 13:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:32:27 INFO - Installing collected packages: mozsystemmonitor 13:32:27 INFO - Running setup.py install for mozsystemmonitor 13:32:27 INFO - Successfully installed mozsystemmonitor 13:32:27 INFO - Cleaning up... 13:32:27 INFO - Return code: 0 13:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32: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==2.5.1'] in /builds/slave/test/build 13:32: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==2.5.1 13:32:27 INFO - Using env: {'DISPLAY': ':0', 13:32:27 INFO - 'HOME': '/home/cltbld', 13:32:27 INFO - 'LANG': 'en_US.UTF-8', 13:32:27 INFO - 'LANGUAGE': 'en_US:en', 13:32:27 INFO - 'LOGNAME': 'cltbld', 13:32:27 INFO - 'MAIL': '/var/mail/cltbld', 13:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:27 INFO - 'MOZ_NO_REMOTE': '1', 13:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:27 INFO - 'NO_EM_RESTART': '1', 13:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:27 INFO - 'PWD': '/builds/slave/test', 13:32:27 INFO - 'SHELL': '/bin/bash', 13:32:27 INFO - 'SHLVL': '1', 13:32:27 INFO - 'TERM': 'linux', 13:32:27 INFO - 'TMOUT': '86400', 13:32:27 INFO - 'USER': 'cltbld', 13:32:27 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:27 INFO - '_': '/tools/buildbot/bin/python'} 13:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:28 INFO - Downloading/unpacking jsonschema==2.5.1 13:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:30 INFO - warning: no files found matching '*.txt' 13:32:30 INFO - no previously-included directories found matching 'build' 13:32:30 INFO - no previously-included directories found matching 'dist' 13:32:30 INFO - no previously-included directories found matching '.git*' 13:32:30 INFO - Installing collected packages: jsonschema, functools32 13:32:30 INFO - Running setup.py install for functools32 13:32:30 INFO - warning: no files found matching '*.txt' 13:32:30 INFO - no previously-included directories found matching 'build' 13:32:30 INFO - no previously-included directories found matching 'dist' 13:32:30 INFO - no previously-included directories found matching '.git*' 13:32:30 INFO - Successfully installed jsonschema functools32 13:32:30 INFO - Cleaning up... 13:32:30 INFO - Return code: 0 13:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:30 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')]} 13:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:30 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')]} 13:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:30 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:30 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 13:32:30 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 13:32:30 INFO - Using env: {'DISPLAY': ':0', 13:32:30 INFO - 'HOME': '/home/cltbld', 13:32:30 INFO - 'LANG': 'en_US.UTF-8', 13:32:30 INFO - 'LANGUAGE': 'en_US:en', 13:32:30 INFO - 'LOGNAME': 'cltbld', 13:32:30 INFO - 'MAIL': '/var/mail/cltbld', 13:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:30 INFO - 'MOZ_NO_REMOTE': '1', 13:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:30 INFO - 'NO_EM_RESTART': '1', 13:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:30 INFO - 'PWD': '/builds/slave/test', 13:32:30 INFO - 'SHELL': '/bin/bash', 13:32:30 INFO - 'SHLVL': '1', 13:32:30 INFO - 'TERM': 'linux', 13:32:30 INFO - 'TMOUT': '86400', 13:32:30 INFO - 'USER': 'cltbld', 13:32:30 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:30 INFO - '_': '/tools/buildbot/bin/python'} 13:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:30 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 13:32:30 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 13:32:30 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 13:32:30 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 13:32:30 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 13:32:30 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 13:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:33 INFO - Downloading docopt-0.6.1.tar.gz 13:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:33 INFO - Running setup.py install for blobuploader 13:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:33 INFO - Running setup.py install for requests 13:32:33 INFO - Running setup.py install for docopt 13:32:33 INFO - Successfully installed blobuploader requests docopt 13:32:33 INFO - Cleaning up... 13:32:33 INFO - Return code: 0 13:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:33 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')]} 13:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:33 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')]} 13:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:33 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:33 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 13:32:33 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 13:32:33 INFO - Using env: {'DISPLAY': ':0', 13:32:33 INFO - 'HOME': '/home/cltbld', 13:32:33 INFO - 'LANG': 'en_US.UTF-8', 13:32:33 INFO - 'LANGUAGE': 'en_US:en', 13:32:33 INFO - 'LOGNAME': 'cltbld', 13:32:33 INFO - 'MAIL': '/var/mail/cltbld', 13:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:33 INFO - 'MOZ_NO_REMOTE': '1', 13:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:33 INFO - 'NO_EM_RESTART': '1', 13:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:33 INFO - 'PWD': '/builds/slave/test', 13:32:33 INFO - 'SHELL': '/bin/bash', 13:32:33 INFO - 'SHLVL': '1', 13:32:33 INFO - 'TERM': 'linux', 13:32:33 INFO - 'TMOUT': '86400', 13:32:33 INFO - 'USER': 'cltbld', 13:32:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:33 INFO - '_': '/tools/buildbot/bin/python'} 13:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:34 INFO - Running setup.py (path:/tmp/pip-inaNy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:34 INFO - Running setup.py (path:/tmp/pip-OPOI54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:34 INFO - Running setup.py (path:/tmp/pip-bDrU_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:34 INFO - Running setup.py (path:/tmp/pip-2XBfB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:34 INFO - Running setup.py (path:/tmp/pip-dzgIdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:34 INFO - Running setup.py (path:/tmp/pip-AOKf_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:34 INFO - Running setup.py (path:/tmp/pip-gQwIm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:34 INFO - Running setup.py (path:/tmp/pip-shTT41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:34 INFO - Running setup.py (path:/tmp/pip-uY1vMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:34 INFO - Running setup.py (path:/tmp/pip-eEOsPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:34 INFO - Running setup.py (path:/tmp/pip-Hv30q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:34 INFO - Running setup.py (path:/tmp/pip-XZpsj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:34 INFO - Running setup.py (path:/tmp/pip-CB_q07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:35 INFO - Running setup.py (path:/tmp/pip-oHmsmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:35 INFO - Running setup.py (path:/tmp/pip-95fEj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:35 INFO - Running setup.py (path:/tmp/pip-rhkiCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:35 INFO - Running setup.py (path:/tmp/pip-GlHMKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:35 INFO - Running setup.py install for manifestparser 13:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:35 INFO - Running setup.py install for mozcrash 13:32:35 INFO - Running setup.py install for mozdebug 13:32:35 INFO - Running setup.py install for mozdevice 13:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:35 INFO - Running setup.py install for mozfile 13:32:35 INFO - Running setup.py install for mozhttpd 13:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:35 INFO - Running setup.py install for mozinfo 13:32:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozInstall 13:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozleak 13:32:36 INFO - Running setup.py install for mozlog 13:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for moznetwork 13:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozprocess 13:32:36 INFO - Running setup.py install for mozprofile 13:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozrunner 13:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Running setup.py install for mozscreenshot 13:32:36 INFO - Running setup.py install for moztest 13:32:36 INFO - Running setup.py install for mozversion 13:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:37 INFO - Cleaning up... 13:32:37 INFO - Return code: 0 13:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:37 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:37 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 13:32:37 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 13:32:37 INFO - Using env: {'DISPLAY': ':0', 13:32:37 INFO - 'HOME': '/home/cltbld', 13:32:37 INFO - 'LANG': 'en_US.UTF-8', 13:32:37 INFO - 'LANGUAGE': 'en_US:en', 13:32:37 INFO - 'LOGNAME': 'cltbld', 13:32:37 INFO - 'MAIL': '/var/mail/cltbld', 13:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:37 INFO - 'MOZ_NO_REMOTE': '1', 13:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:37 INFO - 'NO_EM_RESTART': '1', 13:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:37 INFO - 'PWD': '/builds/slave/test', 13:32:37 INFO - 'SHELL': '/bin/bash', 13:32:37 INFO - 'SHLVL': '1', 13:32:37 INFO - 'TERM': 'linux', 13:32:37 INFO - 'TMOUT': '86400', 13:32:37 INFO - 'USER': 'cltbld', 13:32:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:37 INFO - '_': '/tools/buildbot/bin/python'} 13:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:37 INFO - Running setup.py (path:/tmp/pip-VeG5KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:37 INFO - Running setup.py (path:/tmp/pip-muSAfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:37 INFO - Running setup.py (path:/tmp/pip-g59YZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:37 INFO - Running setup.py (path:/tmp/pip-c9IMzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:37 INFO - Running setup.py (path:/tmp/pip-TApmbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:37 INFO - Running setup.py (path:/tmp/pip-dCl4cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:37 INFO - Running setup.py (path:/tmp/pip-rVJv18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:37 INFO - Running setup.py (path:/tmp/pip-J93Cdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:37 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)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:37 INFO - Running setup.py (path:/tmp/pip-BrQjHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:37 INFO - Running setup.py (path:/tmp/pip-FOjplW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:38 INFO - Running setup.py (path:/tmp/pip-e9Ovvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:38 INFO - Running setup.py (path:/tmp/pip-gWFUsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:38 INFO - Running setup.py (path:/tmp/pip-sG1jlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:38 INFO - Running setup.py (path:/tmp/pip-_vI2Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:38 INFO - Running setup.py (path:/tmp/pip-1LnJoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:38 INFO - Running setup.py (path:/tmp/pip-LWpkrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:38 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)) 13:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:38 INFO - Running setup.py (path:/tmp/pip-H5RzFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 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)) 13:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:43 INFO - Downloading blessings-1.6.tar.gz 13:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:43 INFO - Installing collected packages: blessings 13:32:43 INFO - Running setup.py install for blessings 13:32:43 INFO - Successfully installed blessings 13:32:43 INFO - Cleaning up... 13:32:43 INFO - Return code: 0 13:32:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:43 INFO - Reading from file tmpfile_stdout 13:32:43 INFO - Current package versions: 13:32:43 INFO - argparse == 1.2.1 13:32:43 INFO - blessings == 1.6 13:32:43 INFO - blobuploader == 1.2.4 13:32:43 INFO - docopt == 0.6.1 13:32:43 INFO - functools32 == 3.2.3-2 13:32:43 INFO - jsonschema == 2.5.1 13:32:43 INFO - manifestparser == 1.1 13:32:43 INFO - mozInstall == 1.12 13:32:43 INFO - mozcrash == 0.17 13:32:43 INFO - mozdebug == 0.1 13:32:43 INFO - mozdevice == 0.48 13:32:43 INFO - mozfile == 1.2 13:32:43 INFO - mozhttpd == 0.7 13:32:43 INFO - mozinfo == 0.9 13:32:43 INFO - mozleak == 0.1 13:32:43 INFO - mozlog == 3.2 13:32:43 INFO - moznetwork == 0.27 13:32:43 INFO - mozprocess == 0.22 13:32:43 INFO - mozprofile == 0.28 13:32:43 INFO - mozrunner == 6.11 13:32:43 INFO - mozscreenshot == 0.1 13:32:43 INFO - mozsystemmonitor == 0.3 13:32:43 INFO - moztest == 0.7 13:32:43 INFO - mozversion == 1.4 13:32:43 INFO - psutil == 3.1.1 13:32:43 INFO - requests == 1.2.3 13:32:43 INFO - wsgiref == 0.1.2 13:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:43 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')]} 13:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:43 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')]} 13:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:43 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:43 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 13:32:43 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 13:32:43 INFO - Using env: {'DISPLAY': ':0', 13:32:43 INFO - 'HOME': '/home/cltbld', 13:32:43 INFO - 'LANG': 'en_US.UTF-8', 13:32:43 INFO - 'LANGUAGE': 'en_US:en', 13:32:43 INFO - 'LOGNAME': 'cltbld', 13:32:43 INFO - 'MAIL': '/var/mail/cltbld', 13:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:43 INFO - 'MOZ_NO_REMOTE': '1', 13:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:43 INFO - 'NO_EM_RESTART': '1', 13:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:43 INFO - 'PWD': '/builds/slave/test', 13:32:43 INFO - 'SHELL': '/bin/bash', 13:32:43 INFO - 'SHLVL': '1', 13:32:43 INFO - 'TERM': 'linux', 13:32:43 INFO - 'TMOUT': '86400', 13:32:43 INFO - 'USER': 'cltbld', 13:32:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:43 INFO - '_': '/tools/buildbot/bin/python'} 13:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 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)) 13:32:44 INFO - Cleaning up... 13:32:44 INFO - Return code: 0 13:32:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32:44 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')]} 13:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:44 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')]} 13:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:44 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:44 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 13:32:44 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 13:32:44 INFO - Using env: {'DISPLAY': ':0', 13:32:44 INFO - 'HOME': '/home/cltbld', 13:32:44 INFO - 'LANG': 'en_US.UTF-8', 13:32:44 INFO - 'LANGUAGE': 'en_US:en', 13:32:44 INFO - 'LOGNAME': 'cltbld', 13:32:44 INFO - 'MAIL': '/var/mail/cltbld', 13:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:44 INFO - 'MOZ_NO_REMOTE': '1', 13:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:44 INFO - 'NO_EM_RESTART': '1', 13:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:44 INFO - 'PWD': '/builds/slave/test', 13:32:44 INFO - 'SHELL': '/bin/bash', 13:32:44 INFO - 'SHLVL': '1', 13:32:44 INFO - 'TERM': 'linux', 13:32:44 INFO - 'TMOUT': '86400', 13:32:44 INFO - 'USER': 'cltbld', 13:32:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:44 INFO - '_': '/tools/buildbot/bin/python'} 13:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:32:44 INFO - Cleaning up... 13:32:44 INFO - Return code: 0 13:32:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:44 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')]} 13:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:44 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')]} 13:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:44 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 0x7ffbd65c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1294020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', '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 13:32:44 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 13:32:44 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 13:32:44 INFO - Using env: {'DISPLAY': ':0', 13:32:44 INFO - 'HOME': '/home/cltbld', 13:32:44 INFO - 'LANG': 'en_US.UTF-8', 13:32:44 INFO - 'LANGUAGE': 'en_US:en', 13:32:44 INFO - 'LOGNAME': 'cltbld', 13:32:44 INFO - 'MAIL': '/var/mail/cltbld', 13:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:44 INFO - 'MOZ_NO_REMOTE': '1', 13:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:44 INFO - 'NO_EM_RESTART': '1', 13:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:44 INFO - 'PWD': '/builds/slave/test', 13:32:44 INFO - 'SHELL': '/bin/bash', 13:32:44 INFO - 'SHLVL': '1', 13:32:44 INFO - 'TERM': 'linux', 13:32:44 INFO - 'TMOUT': '86400', 13:32:44 INFO - 'USER': 'cltbld', 13:32:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:44 INFO - '_': '/tools/buildbot/bin/python'} 13:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:44 INFO - Downloading/unpacking flake8 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:44 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 13:32:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:46 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 13:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:47 INFO - no previously-included directories found matching 'docs/_build' 13:32:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:47 INFO - Running setup.py install for pep8 13:32:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:47 INFO - no previously-included directories found matching 'docs/_build' 13:32:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:47 INFO - Cleaning up... 13:32:47 INFO - Return code: 0 13:32:47 INFO - Running post-action listener: _resource_record_post_action 13:32:47 INFO - Running post-action listener: _start_resource_monitoring 13:32:47 INFO - Starting resource monitoring. 13:32:47 INFO - ##### 13:32:47 INFO - ##### Finished create-virtualenv step (success) 13:32:47 INFO - ##### 13:32:47 INFO - ##### 13:32:47 INFO - ##### Running install step. 13:32:47 INFO - ##### 13:32:47 INFO - Running pre-action listener: _resource_record_pre_action 13:32:47 INFO - Running main action method: install 13:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:47 INFO - Reading from file tmpfile_stdout 13:32:47 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:47 INFO - Reading from file tmpfile_stdout 13:32:47 INFO - Output received: 13:32:47 INFO - Usage: mozinstall [options] installer 13:32:47 INFO - Options: 13:32:47 INFO - -h, --help show this help message and exit 13:32:47 INFO - -d DEST, --destination=DEST 13:32:47 INFO - Directory to install application into. [default: 13:32:47 INFO - "/builds/slave/test"] 13:32:47 INFO - --app=APP Application being installed. [default: firefox] 13:32:47 INFO - mkdir: /builds/slave/test/build/application 13:32:47 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'] 13:32:47 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 13:33:03 INFO - Reading from file tmpfile_stdout 13:33:03 INFO - Output received: 13:33:03 INFO - /builds/slave/test/build/application/firefox/firefox 13:33:03 INFO - Running post-action listener: _resource_record_post_action 13:33:03 INFO - ##### 13:33:03 INFO - ##### Finished install step (success) 13:33:03 INFO - ##### 13:33:03 INFO - ##### 13:33:03 INFO - ##### Running run-tests step. 13:33:03 INFO - ##### 13:33:03 INFO - Running pre-action listener: _resource_record_pre_action 13:33:03 INFO - Running main action method: run_tests 13:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:33:03 INFO - Python 2.7.3 13:33:03 INFO - Return code: 0 13:33:03 INFO - grabbing minidump binary from tooltool 13:33: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')]} 13:33:03 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 0x13262e0>, '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 0x1292140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12925d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:33:03 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 13:33:03 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 13:33:03 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 13:33:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:33:03 INFO - Return code: 0 13:33:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:33:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:33:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:33:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:33:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:33:04 INFO - Return code: 0 13:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:33:04 INFO - Using env: {'DISPLAY': ':0', 13:33:04 INFO - 'HOME': '/home/cltbld', 13:33:04 INFO - 'LANG': 'en_US.UTF-8', 13:33:04 INFO - 'LANGUAGE': 'en_US:en', 13:33:04 INFO - 'LOGNAME': 'cltbld', 13:33:04 INFO - 'MAIL': '/var/mail/cltbld', 13:33:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:33:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:04 INFO - 'MOZ_NO_REMOTE': '1', 13:33:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:33:04 INFO - 'NO_EM_RESTART': '1', 13:33:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:04 INFO - 'PWD': '/builds/slave/test', 13:33:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:33:04 INFO - 'SHELL': '/bin/bash', 13:33:04 INFO - 'SHLVL': '1', 13:33:04 INFO - 'TERM': 'linux', 13:33:04 INFO - 'TMOUT': '86400', 13:33:04 INFO - 'USER': 'cltbld', 13:33:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500', 13:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:04 INFO - '_': '/tools/buildbot/bin/python'} 13:33:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:33:05 INFO - mozversion application_buildid: 20160608123529 13:33:05 INFO - mozversion application_changeset: 4c902c5433c7c10b07b302ec856b4789a2fef65d 13:33:05 INFO - mozversion application_display_name: Nightly 13:33:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:33:05 INFO - mozversion application_name: Firefox 13:33:05 INFO - mozversion application_remotingname: firefox 13:33:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:33:05 INFO - mozversion application_vendor: Mozilla 13:33:05 INFO - mozversion application_version: 50.0a1 13:33:05 INFO - mozversion platform_buildid: 20160608123529 13:33:05 INFO - mozversion platform_changeset: 4c902c5433c7c10b07b302ec856b4789a2fef65d 13:33:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:33:05 INFO - mozversion platform_version: 50.0a1 13:33:05 INFO - using testdate: 1465417985 13:33:05 INFO - actual date: 1465417985 13:33:05 INFO - starting webserver on 'localhost:55439' 13:33:05 INFO - SUITE-START | Running 2 tests 13:33:05 INFO - TEST-START | dromaeo_css 13:33:05 INFO - operating with platform_type : linux_ 13:33:05 INFO - Initialising browser for dromaeo_css test... 13:33:05 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8rFux/profile http://localhost:55439/getInfo.html) 13:33:10 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 13:33:10 INFO - PROCESS | 3316 | colorDepth:24 13:33:10 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 13:33:10 INFO - PROCESS | 3316 | __metrics 13:33:12 ERROR - PROCESS | 3316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:33:12 INFO - PROCESS | 3316 | console.error: PushService: 13:33:12 INFO - PROCESS | 3316 | stateChangeProcessEnqueue: Error transitioning state 13:33:12 INFO - PROCESS | 3316 | UnknownError 13:33:13 INFO - TEST-INFO | 3316: exit 0 13:33:13 INFO - Browser initialized. 13:33:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:13 INFO - TEST-INFO | started process 3401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu8rFux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:25 INFO - PROCESS | 3401 | RSS: Main: 157827072 13:33:25 INFO - PROCESS | 3401 | 13:34:16 INFO - PROCESS | 3401 | 1465418056682 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] 13:36:30 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55439/tests/dromaeo/cssquery-ext.html) 13:36:31 INFO - PROCESS | 3401 | RSS: Main: 271286272 13:36:31 INFO - PROCESS | 3401 | 13:39:33 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-ext.html (next: http://localhost:55439/tests/dromaeo/cssquery-jquery.html) 13:39:34 INFO - PROCESS | 3401 | RSS: Main: 240431104 13:39:34 INFO - PROCESS | 3401 | 13:42:36 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55439/tests/dromaeo/cssquery-mootools.html) 13:42:37 INFO - PROCESS | 3401 | RSS: Main: 247296000 13:42:37 INFO - PROCESS | 3401 | 13:45:39 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55439/tests/dromaeo/cssquery-prototype.html) 13:45:40 INFO - PROCESS | 3401 | RSS: Main: 239616000 13:45:40 INFO - PROCESS | 3401 | 13:48:42 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55439/tests/dromaeo/cssquery-yui.html) 13:48:43 INFO - PROCESS | 3401 | RSS: Main: 211468288 13:48:43 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | Cycle 1(1): loaded http://localhost:55439/tests/dromaeo/cssquery-yui.html (next: http://localhost:55439/tests/dromaeo/cssquery-dojo.html) 13:51:46 INFO - PROCESS | 3401 | RSS: Main: 273113088 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | __start_tp_report 13:51:46 INFO - PROCESS | 3401 | _x_x_mozilla_page_load 13:51:46 INFO - PROCESS | 3401 | _x_x_mozilla_page_load_details 13:51:46 INFO - PROCESS | 3401 | |i|pagename|runs| 13:51:46 INFO - PROCESS | 3401 | |0;dojo.html;2673.8663066846657;2684.1008262232153;2693.8383696978176;2714.6199532065502;2729.304027472995;4625.699329543586;4704.0356726871;4752.786124624392;4810.278458231267;4846.0307938412325;4721.811127554894;4741.668083234175;4746.359241502396;4792.065547218293;4802.159622066142;4395.318725597522;4406.47122345319;4417;4430.047539778947;4434.1575100730915;4381.561843815625;4475.261581839009;4484.1928452878465;4503.752293623849;4530.524294949032;4418.756968366739;4463.977680111611;4470.530594287602;4482.350059241408;4509.954900451003;4225.598568136023;4310.762908040057;4338.370936214231;4354.150940566591;4396.736195828228;4330.761808100553;4372.256716358227;4378.299472084483;4383.605475507188;4413.426254586915;4693.55411235932;4723.244280915072;4724;4730.243161094243;4744.478107408182;4903.166461701519;4990.725510096943;5090.618203634742;5135.768890399941;5192.61055420845;5134.743262836881;5145.76844042019;5174.275601415805;5190.351206099238;5205.869853253661;4659.138059459011;4751.809927602926;4756.643251756063;4772.76136193189;4801.015791762715;5133.25567792668;5224.216367544898;5239.973800130975;5245.659032162897;5312.707801070901;5029.06962211992;5064.645474816727;5077.390713114376;5081.517255860687;5084.237364395371;4921.163402221631;5072.898542029138;5163.586913046947;5168.966206758663;5176.792928282826;5034.647574669812;5050.873728156752;5055.873603159876;5072.82245121419;5100.903305789273;5022.522860328336;5033.295338652591;5038.067957427887;5078.162103252996;5087.949120508822;4225.281702110648;4260.957390426118;4297.656187504992;4344.3483477478;4392.802323895432;3747.2880152770886;3761.830717617659;3769.26499332633;3798;3824.4072168813877;4338.978305108518;4349.304111342233;4350.129974005148;4378.5183629800695;4390.780460976938;4971.776270067856;5032.270320803463;5047.16721740916;5114.207297868837;5140.717260550706;4317.762523061262;4320.567943205654;4345.608895199384;4350.73895566267;4358.411614432074;4541.273396256649;4557.065801510682;4558.521355257651;4562.543745625478;4607.608353289941;4693.882652933567;4774.856754297377;4808.206645903527;4809.759512024455;4839;5118.590512758896;5146.485351464824;5176.1200595898035;5198.116320225495;5204.37547494288;4868.050730107595;4878.438979517401;4880.536349046835;4880.536349046835;4890.510948905081;4913;4954.826581069789;4982;5010.348654674869;5026.632315199456;5075.492450754895;5077.111505486451;5077.2637967493765;5095.617828662791;5119.411267704261;4929.186684197068;4942.851714448572;4944.579710724629;4945;4984.7258400788305;4795.6163506918665;4903.068417000758;4962.925556116589;4993.151164302005;4995.900081998412;4859.271109333628;4895.094407534618;4934.679245849008;4938.827141050046;4939.97530012362;4862.805487780449;5027.095122877917;5035.647504674637;5042.873928151826;5073.543381095719;4864.148773964613;4905.877353066202;4933.925991110064;4937.728424936519;4952.678075925053 13:51:46 INFO - PROCESS | 3401 | |1;ext.html;557.5650992226062;591.464724424396;598.9371116032817;599.0744300056413;607.0529973241742;27896.581551276722;30680.232994175156;30892.84553577229;40141.19717605646;41232.58767412325;38613.613863861356;39016.21967560654;39045.41431878524;39045.804770976174;39116.608833911654;7733.0720313562315;7915.4063445241545;7917.089534703525;7917.247861453182;7923.2869041786225;7671.539707617533;7793.8051548711455;7796.844063118734;7801;7806.024246969129;7801.180876008023;7864.960675196616;7865.174156713549;7866.567338796364;7866.68533258669;7795.883061754078;7833.686652533892;7851.097123830776;7852.057753069668;7852.175521570267;7741.651625676858;7839.1768864269;7841.411894107965;7842.058952925629;7843.294103530652;38449.80775096134;38890.416643750366;38891.80554097211;38912.41631375532;38925;2854.200823769348;3065.432894914448;3110.891118810831;3345.6654334566592;3629.6551827576336;26490.205293841216;26777.330566735793;29289;29797.70202297971;30037.249068773235;3374.8143852088124;3438.415469370213;3526.312369088029;3530.287810411948;3531.9293614127832;235454;235643.99999999828;236669;236700;238261;31184.41379241371;32485.837570812466;52499.21251181235;52502;52583;33426.665733342845;33427.331453370796;33437.83281083579;33585.328293433995;33635.32729345448;13732.794008089886;13860.653483662787;13870.653233669038;13890.861091389159;13890.930545347208;10261.281710280358;10280.588776448858;10281.897181028244;10285.28003039795;10318.587256509656;7926.564038977796;7944.761657150295;7960.960195198987;8010.639521221559;8029.919700803034;3065.0804758572785;3089.7528197744577;3099.9380012399624;3162.098801841464;3180.904572862818;926.1340646495548;967.7193613852045;970.3751352591224;1007.8387458006683;1043.634727845248;27169.456610867674;27275.727242727717;27309.180724578295;27445.58831617527;27812;929.7257309093834;1027.1012863744224;1034.2966782587912;1036.108946306176;1081.6160263106642;14652.413903443743;14675.92662036683;14727.116373017654;14885.404583816742;14966.850331496546;303581;304677;305982;306236;307284;48477;48900;48976.26535601897;48978.75510622424;48991.51008489869;1090.9563617455372;1141.0643272516456;1169.7660467906453;1234.9073819463397;1238.8203710461933;27605.30986725348;29293.70706292995;29663.85168074146;29726.702732972393;30114.849425753608;43129.784351079295;43503.56496434995;43617.34573981456;43675.56324436715;43702.78148609237;285365;288917;289971;291048;291130;21314.467138321044;23179;25630.871845640653;25694.614580781676;26086.217413477625;42334.57665423306;42564.57435425606;42828.78585607052;43516.34725479057;43540;34901;36562;37091;37175;37469.81265093657;36105.638943610225;36321.27357452889;36601.117843032334;36667.63332366642;37190.44214336733;30846.845765771028;35508.467372989944;35893.461598075526;36738.08154796151;36817.07957301089;30439.84780076174;32927.835360824;33365.49951750774;33635.66364336325;33737.493937590465;24708.629370559815;25334.619980699936;25374.492510149325;25515.6172657414;25756.356091097125 13:51:46 INFO - PROCESS | 3401 | |2;jquery.html;367.3681268218664;369.88348670168875;370.24839575661406;378.9071677439028;379.78352339166685;15454.61363465914;17060.488185354458;17121.22954467049;17499.737503937453;17654;15903.44337948172;16588.917055414735;17247.31010759568;17255.568610784736;17272.481825545223;4734.90530189396;4887.0225954809;4890.339804126451;5084.084864724348;5103.770330335144;3682.1346983458866;5002.899942001158;5679.517241034517;5984.7306871190685;6004.0693692477735;5926.644401335933;5929.940700593003;5946.137810017545;5947.375525569796;5953.58324917256;5840.153177789197;5882.264716910387;5964.940350596504;5965.403459654043;5997.970010149921;3327.2513684421056;4862.708237505761;5163.380394352665;5176.50823171798;5241.528262456397;19782.50543736418;20379.388618341327;20397.592048159102;20725;20739.68890466629;1929.411529483507;1988.9005549722456;2025.2405347994502;2216.6342553478657;2289.7252329720372;12863.871361286454;12877.162984406077;12932.935335323264;13089.738205235937;13312.800307995389;1712.3150739704095;1755.5172327609882;1762.118940529735;1774.7480970646036;1780.4836597386743;61787;62311.688441557955;62976.37023629751;63430.68284658547;64066.679666601834;8210.343172546181;8665.74002779905;8833.558322083998;8950.328725345495;9039.593218305192;11857.407129643656;11873.584424545099;11902.40487975615;11929.522819087313;11960.760784784256;6908.965455172793;7095.751648692271;7123.465740069516;7224.169220539705;7231.3130252625915;7043.718251269995;7085.50401471892;7185.101862267216;7206.279372062857;7241.5293005954445;3675.7243206759067;3686.4654625079215;3736.1033351995325;3753.3431649461236;3834.9041273968373;1600.311671186909;1682.3354774864106;1766.3287950578697;1825.963480730378;1834.9816501835078;387.0536538164218;388.2642392665882;391.8648066417081;410.06914304528556;818.9303909167668;9957.651482198233;9996.800063998824;10252.58989640421;10371.274010819321;10501.737456563495;397.73351854257714;399.1358708396347;402.915387768566;413.3881854854832;414.1137964755426;5372.328458942632;5421.647592906527;5422.240886275925;5560.666360018412;5635.239242702265;381732;386130;386422;393331;397590;50723.23915141276;51754.48245517497;53350.7332463343;79526.60236698895;84487.5775621118;414.3515398401492;420.74544900334854;421.4605305209337;422.16832839306517;423.5214207945064;9467.715968520955;9484.95257523708;9604.95197524008;9658.951705241428;9840.360376575785;33927;34103;34756.65243347534;34852;35969.64030359663;49235.26147107868;49727.502724972284;49742.25386619276;49931.50068499269;50158.247626286364;7424.183339832722;7649.885251721117;7709.2290770922455;7709.9614501927135;7827.882581761164;11381.886181138414;11537.596184133516;11738.119641026786;11745.647630571097;11939.701507462383;9755.951220244136;9763.316567840184;9893.802123957337;10012.899871001197;10138.294895879037;9069.093090690878;9097.636094556143;10244.282900196915;10279.53742081623;10519.712637097064;10012.799744004933;10094.394336339843;10108;10355.689329320132;10439.321444106108;7382.483226174331;7460.515066520658;7612.3910087194;7671.002769639911;7724.304812566671;9061.365704400629;10209.489525523546;10221.74445638865;10229.232807539613;10298.116428160256 13:51:46 INFO - PROCESS | 3401 | |3;mootools.html;1265.5127775806322;1380.8342998840137;1450.7606244969577;1522.9314680839361;1736.3228340947032;6736.191657001161;7607.353374963128;7850.0579930408285;7852.489588176764;8046.275835174833;7743.690252389912;7906.683732650701;7918.406119541029;7922;7922.3266022388025;1830.560665440298;1888.5089876632105;1889.8582606304512;2185.2242453928825;2219.7447293561286;1944.6596845552042;2164.545445456456;2227.3652009177385;2228.0642130305228;2252.2680128958073;2161.1139432832542;2169.327508472371;2180.029886700419;2188.5732282204976;2195.6157672407344;1782.465260421881;2134.583756167548;2143.3141394753684;2145.056175282886;2150.2904041666293;2044.5604195097976;2103.368989303203;2108.1778106538463;2124.649432843579;2125.08621292844;7804.49270797402;7829.530228186327;7854.057513098408;7858.724944626968;7875.212478752136;4331.155424692186;4468.173387923244;4470.687051906368;4470.955290447087;4479.686421950465;2754.986225068882;2832.3344014156655;2875.252434367059;2908.243856597279;2916.4458752836895;890.679355432044;891.2558014058269;916.8441364967971;919.0350132360994;921.4333185091187;10411.219158563063;10415.479226038668;10417.427041512714;10423.791524169474;10429;4231.703780735319;4242.215190189825;4343.630791382768;4351.499577548622;4355.760433176142;9144.497052662035;9150.816983660423;9160.541972901328;9161.541922903829;9171.495567743837;4608.400907882021;4612.400387949545;4613.677042606985;4618.49196588375;4618.838340658061;3609.1338078860886;3630.9373311321897;4091.2022155679356;4186.644135248538;4216.30430978885;3576.4277715565386;3705.4256590228556;3785.5078839750654;3825.6365645263654;3838.6353296436796;1150.6375491720082;1160.808466603001;1172.8709841917553;1180.2564384437921;1184.579474286633;726.2084328082416;781.9765407037798;786.390547325827;792.0495405513407;807.9192080791992;5223.085959956992;5238.345206849144;5254.947450525446;5390.407055223922;5390.730463476811;384.50782997762906;412.2846860696689;419.0403974897451;420.0884081543059;421.62896650947584;3464.3764122457696;3471.3057388522398;3515.876944306937;3543.5216245807;3562.1450851795385;9166.312526560534;9846.163076138608;9870.407775533347;9906.851397229048;9972.351797133164;9625.807483850283;9816.852747208797;9874.308798384043;9893.406395616286;9918.900810991941;7499.175090740015;7544.094708634889;7592.696292148252;7593.240675932473;7600.3539699126195;5130.666506677203;5138.177891537336;5139.254808052886;5266.210068489757;5296.073187192303;9070.410423322463;9070.81858362816;9197.172254497127;9204.355695101278;9218.677346292847;9032.63869445215;9372.109649583279;9482.099200575934;9488.715338539854;9505.144536991704;5888.4700376966275;6102.6643534604245;6669.833254168685;6685.364890335605;6741.52809303344;7196.604186769778;7471.701131954661;7487.438442116972;7489.775306740807;7496.662650180864;6429.4534964526665;6746.460283177236;6752.69612867432;6773.288804675438;6808.217055038536;6563.113979612691;6589.769358072444;6636.502262330441;6660.467162626881;6685.164354455693;5925.05199168131;5995.730192141451;6003.489703375262;6006.549508786946;6041.033434650435;4384.780760961876;4469;4555.430571178603;4561.471906911222;4584.312353147055;4371.9344209836245;4400.1199760047475;4409.691321607456;4511.774411279489;4529.411176547028 13:51:46 INFO - PROCESS | 3401 | |4;prototype.html;298.7251728409863;303.95136778115506;308.2140541618872;312.0311433000535;313.96546379898206;4800.183968725316;4823.228283474645;4823.662343635947;4843.685160464567;4856.951430485694;4798.592119669832;4806.158922188621;4814;4828.661993660445;4829.589484893788;3621.1128273573013;3707.2214834884708;3722.906927326825;3728.6457786510373;3729.142297271629;3616.2044350242904;3742.251549690059;3802.258559580883;3822.140018495844;3877.0501227199375;3735.981320093396;3765.7363984521094;3784.2431513697234;3794.753341032838;3811.218700166473;3541.6635419635095;3728.3714980938375;3778.7732736035928;3790.90522736931;3800.90497737556;3242.3515296940473;3243.1567792373917;3248.0580631616804;3250.5449237106823;3260.2990357073345;4524.298733696282;4531.297648864432;4535.297028960516;4547.20423925815;4553.2942393929;4208.705390622657;4213.304804707251;4213.5042060068845;4228.4080228768;4248.171606536726;4708.270218116198;4947.876303092416;4958.528939750718;4961.950380496185;5039.294498770175;3533.840977156034;3534.68187863091;3551.8756843510355;3552.378333791602;3574.857005719768;5276.944611077762;5313.495217954288;5315.627906046579;5323.653962492464;5330.546903513167;3572;3635.8365323096355;3647.2340808429994;3651.302144502819;3678.7240956928335;3642.8724994625063;3697.7781333120097;3716.2753263113973;3720.534933133358;3724.776513409204;4203.17162034516;4232.153569286155;4238.660907127422;4264.957350426518;4266.786660666954;5018.741566295182;5036.244563315532;5041.8487445376695;5043.87390315245;5071.7971281149075;1206.4148887789415;1266.6136828267468;1267.0623738433492;1269.0165122030317;1269.4795133995203;787.8424315136881;794.4716763352421;800.9199080091944;811.6388207247836;826.2563692676518;4227.471566054243;4360.367746676714;4393.923488745214;4416.381706561084;4426.1369033038245;5196.662216955886;5204.9219261711105;5216.817411390583;5221.869453263699;5222.738863056832;4411.580899814512;4412.0955204183065;4430.645548356124;4431.977840110779;4436.402894957812;2538.2765911715073;2741.7943654226015;2753.2428582140074;2757.7104404037686;2763.557830747111;4890.119778439844;4891.486393928657;4899.534544218365;4909.1654418748185;4923.433805112386;5059.443461219263;5313.468653134656;5326.280952071498;5340.172273297645;5365.195220716923;4895.265710143436;4895.947371315042;4897.338859254026;4923.359963204761;4923.90152196954;5181.481851814789;5198.610104242272;5206.921896171636;5211.609129315392;5226.189940559219;4904.435989861212;5037.974810125926;5115.56517696;5132.871678208075;5134.306868572695;4874.2201247800185;4903.632227583017;4912.813797859918;4915.967646794214;4920.507949205051;3645.216278500135;3654.744167908221;3694.3534881395112;3709.5548534176073;3714.832832522597;4927.679700819435;5235.214717792209;5247.55395791362;5250.212468129811;5267.73661316925;5027.899442011066;5043.2687260347775;5058.595312375075;5061.898762024813;5064.82273120439;5006.624503162205;5016.799328026984;5025.296458495886;5048.334049763643;5049.823256186163;4726.125666751662;4901.58336541398;4940.901181976412;4955.5044495550155;4956.925646115384;4768.189407800613;4921.68680720061;5027.899442011212;5034.874128146826;5040.42035165946;4925.975370123127;4964.25536169563;4971.477994810638;4987.750612469435;4990.775415106402 13:51:46 INFO - PROCESS | 3401 | |5;yui.html;687.3435868745352;716.5628966330537;722.94577906657;723.7611588175903;750.5909279442703;11608.187426880122;12258.448369823356;12267;12348.382580870943;12375.257484550912;12142.757144857098;12146.514139434434;12192.024638028959;12209.08431867609;12214.32821194834;619.9287081985561;768.3507436216388;770.9845803083921;785.305005070511;793.5318162284251;775.1163673412315;775.2789905387987;778.8286576953061;780.0678189563474;780.336713793274;837.937154713399;841.1378337204353;841.2176675691604;841.3479553346175;841.8063845315581;661.3221448015798;813.7762115418249;835.8704400817852;836.8995720513517;837.6021389839777;575.8099827057061;575.9798407055733;577.2553406106118;577.3447137498927;594.7531774313654;12838.229706217564;12913.935430322883;12920.935395323057;12930.612081637566;12932.224066555942;12620.495180192873;13321.13412628176;13377.66555836102;13394.665133371645;13458.192508449427;10524.210684198715;10824.67525974222;10848.457577121191;10903.236773425864;11201.719957001058;3371.898843034713;3392.490341797901;3393.6776006279365;3430.8627654893776;3445.707114895212;58259.70870145622;58512.41487585155;59050.704746476425;59763.40236597622;59976.40023599752;10781.568737250422;10854.45727713611;10951.726206844893;10969.683637963495;11051.834222486668;20099.19603215884;20110;20132.59734805325;20206.19175232974;20268.89865550663;6764.645662606775;6905.689243983932;6918.688659010357;7152.964235178895;7157.4274058075225;3727.683146932487;3817.4464702617965;3823.5794062653085;3825.6556909877686;3861.768293902375;2860.9284767880554;3008.864601092956;3009.0521485731924;3013.472642287591;3023.455777959988;505.9443461219263;525.5454032262065;525.8369905329283;530.6975024236149;532.5739408473206;445.6167695781625;469.81911963894146;475.46747642640463;509.0785677922971;511.3786749099787;7396.4452666050265;7421.851562968711;7530.962345188349;7544.698212071566;7653.4642575020325;429.35167896475923;491.36368402917594;502.50252250271967;509.83757033962627;527.9788808447619;3563.55455568054;3763.6989040876665;3783.7162212834146;3806.1436176859984;3852.8651497197466;58812;60382.698086509285;61043.69478152581;61220.38779612147;66177.66911165413;53454.19818702723;63002;85551.57224213963;85920;87466.12533874706;73159.63420182865;73432.63283683547;77150.22849771543;77509;77684.2231577677;7300.926990730025;7304.63476826146;7336.7432139874845;7516.962415188108;7554.093508778982;37703;41116.58883411127;42487.15025699407;45783.77108114438;48455.27317090317;57993.71003144957;59123;60357.698211508665;60369.698151508965;60415.56259936627;11291.153163512605;11399.316041037564;11447.198696091527;11786.58746943853;12025.338606376734;11417;11616.477258523555;11619.477123529292;12790.36048197605;12866.614001579968;10831.891681083403;10934.890651093387;11231.26996745209;11515.53937842477;11623.302601843916;7994.440389172702;8367.205115514016;8591.570421479026;8603.91396086031;8613.181747733955;10337.431441270803;11063.944680276547;11110.11119110453;11112.111031117653;11221.438928053727;8834.734957951016;9127.908720912706;9251.814963700823;9399.671011514563;9867.11195992364;8944.642214311354;9525.90474095278;9652.90347096548;9668.126868711028;9843.409395436296 13:51:46 INFO - PROCESS | 3401 | __end_tp_report 13:51:46 INFO - PROCESS | 3401 | __start_cc_report 13:51:46 INFO - PROCESS | 3401 | _x_x_mozilla_cycle_collect,1045 13:51:46 INFO - PROCESS | 3401 | __end_cc_report 13:51:46 INFO - PROCESS | 3401 | __startTimestamp1465419106582__endTimestamp 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | ------- Summary: start ------- 13:51:46 INFO - PROCESS | 3401 | Number of tests: 6 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#0] dojo.html Cycles:165 Average:4712.69 Median:4862.81 stddev:490.21 (10.1%) stddev-sans-first:464.89 13:51:46 INFO - PROCESS | 3401 | Values: 2673.9 2684.1 2693.8 2714.6 2729.3 4625.7 4704.0 4752.8 4810.3 4846.0 4721.8 4741.7 4746.4 4792.1 4802.2 4395.3 4406.5 4417.0 4430.0 4434.2 4381.6 4475.3 4484.2 4503.8 4530.5 4418.8 4464.0 4470.5 4482.4 4510.0 4225.6 4310.8 4338.4 4354.2 4396.7 4330.8 4372.3 4378.3 4383.6 4413.4 4693.6 4723.2 4724.0 4730.2 4744.5 4903.2 4990.7 5090.6 5135.8 5192.6 5134.7 5145.8 5174.3 5190.4 5205.9 4659.1 4751.8 4756.6 4772.8 4801.0 5133.3 5224.2 5240.0 5245.7 5312.7 5029.1 5064.6 5077.4 5081.5 5084.2 4921.2 5072.9 5163.6 5169.0 5176.8 5034.6 5050.9 5055.9 5072.8 5100.9 5022.5 5033.3 5038.1 5078.2 5087.9 4225.3 4261.0 4297.7 4344.3 4392.8 3747.3 3761.8 3769.3 3798.0 3824.4 4339.0 4349.3 4350.1 4378.5 4390.8 4971.8 5032.3 5047.2 5114.2 5140.7 4317.8 4320.6 4345.6 4350.7 4358.4 4541.3 4557.1 4558.5 4562.5 4607.6 4693.9 4774.9 4808.2 4809.8 4839.0 5118.6 5146.5 5176.1 5198.1 5204.4 4868.1 4878.4 4880.5 4880.5 4890.5 4913.0 4954.8 4982.0 5010.3 5026.6 5075.5 5077.1 5077.3 5095.6 5119.4 4929.2 4942.9 4944.6 4945.0 4984.7 4795.6 4903.1 4962.9 4993.2 4995.9 4859.3 4895.1 4934.7 4938.8 4940.0 4862.8 5027.1 5035.6 5042.9 5073.5 4864.1 4905.9 4933.9 4937.7 4952.7 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#1] ext.html Cycles:180 Average:42559.54 Median:18556.15 stddev:73027.46 (393.5%) stddev-sans-first:73164.23 13:51:46 INFO - PROCESS | 3401 | Values: 557.6 591.5 598.9 599.1 607.1 27896.6 30680.2 30892.8 40141.2 41232.6 38613.6 39016.2 39045.4 39045.8 39116.6 7733.1 7915.4 7917.1 7917.2 7923.3 7671.5 7793.8 7796.8 7801.0 7806.0 7801.2 7865.0 7865.2 7866.6 7866.7 7795.9 7833.7 7851.1 7852.1 7852.2 7741.7 7839.2 7841.4 7842.1 7843.3 38449.8 38890.4 38891.8 38912.4 38925.0 2854.2 3065.4 3110.9 3345.7 3629.7 26490.2 26777.3 29289.0 29797.7 30037.2 3374.8 3438.4 3526.3 3530.3 3531.9 235454.0 235644.0 236669.0 236700.0 238261.0 31184.4 32485.8 52499.2 52502.0 52583.0 33426.7 33427.3 33437.8 33585.3 33635.3 13732.8 13860.7 13870.7 13890.9 13890.9 10261.3 10280.6 10281.9 10285.3 10318.6 7926.6 7944.8 7961.0 8010.6 8029.9 3065.1 3089.8 3099.9 3162.1 3180.9 926.1 967.7 970.4 1007.8 1043.6 27169.5 27275.7 27309.2 27445.6 27812.0 929.7 1027.1 1034.3 1036.1 1081.6 14652.4 14675.9 14727.1 14885.4 14966.9 303581.0 304677.0 305982.0 306236.0 307284.0 48477.0 48900.0 48976.3 48978.8 48991.5 1091.0 1141.1 1169.8 1234.9 1238.8 27605.3 29293.7 29663.9 29726.7 30114.8 43129.8 43503.6 43617.3 43675.6 43702.8 285365.0 288917.0 289971.0 291048.0 291130.0 21314.5 23179.0 25630.9 25694.6 26086.2 42334.6 42564.6 42828.8 43516.3 43540.0 34901.0 36562.0 37091.0 37175.0 37469.8 36105.6 36321.3 36601.1 36667.6 37190.4 30846.8 35508.5 35893.5 36738.1 36817.1 30439.8 32927.8 33365.5 33635.7 33737.5 24708.6 25334.6 25374.5 25515.6 25756.4 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#2] jquery.html Cycles:180 Average:23126.79 Median:411.73 stddev:63994.77 (15542.9%) stddev-sans-first:64151.48 13:51:46 INFO - PROCESS | 3401 | Values: 367.4 369.9 370.2 378.9 379.8 15454.6 17060.5 17121.2 17499.7 17654.0 15903.4 16588.9 17247.3 17255.6 17272.5 4734.9 4887.0 4890.3 5084.1 5103.8 3682.1 5002.9 5679.5 5984.7 6004.1 5926.6 5929.9 5946.1 5947.4 5953.6 5840.2 5882.3 5964.9 5965.4 5998.0 3327.3 4862.7 5163.4 5176.5 5241.5 19782.5 20379.4 20397.6 20725.0 20739.7 1929.4 1988.9 2025.2 2216.6 2289.7 12863.9 12877.2 12932.9 13089.7 13312.8 1712.3 1755.5 1762.1 1774.7 1780.5 61787.0 62311.7 62976.4 63430.7 64066.7 8210.3 8665.7 8833.6 8950.3 9039.6 11857.4 11873.6 11902.4 11929.5 11960.8 6909.0 7095.8 7123.5 7224.2 7231.3 7043.7 7085.5 7185.1 7206.3 7241.5 3675.7 3686.5 3736.1 3753.3 3834.9 1600.3 1682.3 1766.3 1826.0 1835.0 387.1 388.3 391.9 410.1 818.9 9957.7 9996.8 10252.6 10371.3 10501.7 397.7 399.1 402.9 413.4 414.1 5372.3 5421.6 5422.2 5560.7 5635.2 381732.0 386130.0 386422.0 393331.0 397590.0 50723.2 51754.5 53350.7 79526.6 84487.6 414.4 420.7 421.5 422.2 423.5 9467.7 9485.0 9605.0 9659.0 9840.4 33927.0 34103.0 34756.7 34852.0 35969.6 49235.3 49727.5 49742.3 49931.5 50158.2 7424.2 7649.9 7709.2 7710.0 7827.9 11381.9 11537.6 11738.1 11745.6 11939.7 9756.0 9763.3 9893.8 10012.9 10138.3 9069.1 9097.6 10244.3 10279.5 10519.7 10012.8 10094.4 10108.0 10355.7 10439.3 7382.5 7460.5 7612.4 7671.0 7724.3 9061.4 10209.5 10221.7 10229.2 10298.1 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#3] mootools.html Cycles:180 Average:5108.23 Median:5134.42 stddev:2939.39 (57.2%) stddev-sans-first:2933.45 13:51:46 INFO - PROCESS | 3401 | Values: 1265.5 1380.8 1450.8 1522.9 1736.3 6736.2 7607.4 7850.1 7852.5 8046.3 7743.7 7906.7 7918.4 7922.0 7922.3 1830.6 1888.5 1889.9 2185.2 2219.7 1944.7 2164.5 2227.4 2228.1 2252.3 2161.1 2169.3 2180.0 2188.6 2195.6 1782.5 2134.6 2143.3 2145.1 2150.3 2044.6 2103.4 2108.2 2124.6 2125.1 7804.5 7829.5 7854.1 7858.7 7875.2 4331.2 4468.2 4470.7 4471.0 4479.7 2755.0 2832.3 2875.3 2908.2 2916.4 890.7 891.3 916.8 919.0 921.4 10411.2 10415.5 10417.4 10423.8 10429.0 4231.7 4242.2 4343.6 4351.5 4355.8 9144.5 9150.8 9160.5 9161.5 9171.5 4608.4 4612.4 4613.7 4618.5 4618.8 3609.1 3630.9 4091.2 4186.6 4216.3 3576.4 3705.4 3785.5 3825.6 3838.6 1150.6 1160.8 1172.9 1180.3 1184.6 726.2 782.0 786.4 792.0 807.9 5223.1 5238.3 5254.9 5390.4 5390.7 384.5 412.3 419.0 420.1 421.6 3464.4 3471.3 3515.9 3543.5 3562.1 9166.3 9846.2 9870.4 9906.9 9972.4 9625.8 9816.9 9874.3 9893.4 9918.9 7499.2 7544.1 7592.7 7593.2 7600.4 5130.7 5138.2 5139.3 5266.2 5296.1 9070.4 9070.8 9197.2 9204.4 9218.7 9032.6 9372.1 9482.1 9488.7 9505.1 5888.5 6102.7 6669.8 6685.4 6741.5 7196.6 7471.7 7487.4 7489.8 7496.7 6429.5 6746.5 6752.7 6773.3 6808.2 6563.1 6589.8 6636.5 6660.5 6685.2 5925.1 5995.7 6003.5 6006.5 6041.0 4384.8 4469.0 4555.4 4561.5 4584.3 4371.9 4400.1 4409.7 4511.8 4529.4 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#4] prototype.html Cycles:180 Average:4171.11 Median:4810.08 stddev:1223.12 (25.4%) stddev-sans-first:1191.52 13:51:46 INFO - PROCESS | 3401 | Values: 298.7 304.0 308.2 312.0 314.0 4800.2 4823.2 4823.7 4843.7 4857.0 4798.6 4806.2 4814.0 4828.7 4829.6 3621.1 3707.2 3722.9 3728.6 3729.1 3616.2 3742.3 3802.3 3822.1 3877.1 3736.0 3765.7 3784.2 3794.8 3811.2 3541.7 3728.4 3778.8 3790.9 3800.9 3242.4 3243.2 3248.1 3250.5 3260.3 4524.3 4531.3 4535.3 4547.2 4553.3 4208.7 4213.3 4213.5 4228.4 4248.2 4708.3 4947.9 4958.5 4962.0 5039.3 3533.8 3534.7 3551.9 3552.4 3574.9 5276.9 5313.5 5315.6 5323.7 5330.5 3572.0 3635.8 3647.2 3651.3 3678.7 3642.9 3697.8 3716.3 3720.5 3724.8 4203.2 4232.2 4238.7 4265.0 4266.8 5018.7 5036.2 5041.8 5043.9 5071.8 1206.4 1266.6 1267.1 1269.0 1269.5 787.8 794.5 800.9 811.6 826.3 4227.5 4360.4 4393.9 4416.4 4426.1 5196.7 5204.9 5216.8 5221.9 5222.7 4411.6 4412.1 4430.6 4432.0 4436.4 2538.3 2741.8 2753.2 2757.7 2763.6 4890.1 4891.5 4899.5 4909.2 4923.4 5059.4 5313.5 5326.3 5340.2 5365.2 4895.3 4895.9 4897.3 4923.4 4923.9 5181.5 5198.6 5206.9 5211.6 5226.2 4904.4 5038.0 5115.6 5132.9 5134.3 4874.2 4903.6 4912.8 4916.0 4920.5 3645.2 3654.7 3694.4 3709.6 3714.8 4927.7 5235.2 5247.6 5250.2 5267.7 5027.9 5043.3 5058.6 5061.9 5064.8 5006.6 5016.8 5025.3 5048.3 5049.8 4726.1 4901.6 4940.9 4955.5 4956.9 4768.2 4921.7 5027.9 5034.9 5040.4 4926.0 4964.3 4971.5 4987.8 4990.8 13:51:46 INFO - PROCESS | 3401 | 13:51:46 INFO - PROCESS | 3401 | [#5] yui.html Cycles:180 Average:16156.16 Median:525.69 stddev:21903.63 (4166.6%) stddev-sans-first:21934.27 13:51:46 INFO - PROCESS | 3401 | Values: 687.3 716.6 722.9 723.8 750.6 11608.2 12258.4 12267.0 12348.4 12375.3 12142.8 12146.5 12192.0 12209.1 12214.3 619.9 768.4 771.0 785.3 793.5 775.1 775.3 778.8 780.1 780.3 837.9 841.1 841.2 841.3 841.8 661.3 813.8 835.9 836.9 837.6 575.8 576.0 577.3 577.3 594.8 12838.2 12913.9 12920.9 12930.6 12932.2 12620.5 13321.1 13377.7 13394.7 13458.2 10524.2 10824.7 10848.5 10903.2 11201.7 3371.9 3392.5 3393.7 3430.9 3445.7 58259.7 58512.4 59050.7 59763.4 59976.4 10781.6 10854.5 10951.7 10969.7 11051.8 20099.2 20110.0 20132.6 20206.2 20268.9 6764.6 6905.7 6918.7 7153.0 7157.4 3727.7 3817.4 3823.6 3825.7 3861.8 2860.9 3008.9 3009.1 3013.5 3023.5 505.9 525.5 525.8 530.7 532.6 445.6 469.8 475.5 509.1 511.4 7396.4 7421.9 7531.0 7544.7 7653.5 429.4 491.4 502.5 509.8 528.0 3563.6 3763.7 3783.7 3806.1 3852.9 58812.0 60382.7 61043.7 61220.4 66177.7 53454.2 63002.0 85551.6 85920.0 87466.1 73159.6 73432.6 77150.2 77509.0 77684.2 7300.9 7304.6 7336.7 7517.0 7554.1 37703.0 41116.6 42487.2 45783.8 48455.3 57993.7 59123.0 60357.7 60369.7 60415.6 11291.2 11399.3 11447.2 11786.6 12025.3 11417.0 11616.5 11619.5 12790.4 12866.6 10831.9 10934.9 11231.3 11515.5 11623.3 7994.4 8367.2 8591.6 8603.9 8613.2 10337.4 11063.9 11110.1 11112.1 11221.4 8834.7 9127.9 9251.8 9399.7 9867.1 8944.6 9525.9 9652.9 9668.1 9843.4 13:51:46 INFO - PROCESS | 3401 | -------- Summary: end -------- 13:51:46 INFO - PROCESS | 3401 | 13:51:47 INFO - TEST-INFO | 3401: exit 0 13:51:47 INFO - TEST-OK | dromaeo_css | took 1122048ms 13:51:47 INFO - TEST-START | kraken 13:51:47 INFO - operating with platform_type : linux_ 13:51:47 INFO - Initialising browser for kraken test... 13:51:47 INFO - TEST-INFO | started process 3577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lj55P/profile http://localhost:55439/getInfo.html) 13:51:51 INFO - PROCESS | 3577 | __metrics Screen width/height:1600/1200 13:51:51 INFO - PROCESS | 3577 | colorDepth:24 13:51:51 INFO - PROCESS | 3577 | Browser inner width/height: 1024/697 13:51:51 INFO - PROCESS | 3577 | __metrics 13:51:52 ERROR - PROCESS | 3577 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:51:52 INFO - PROCESS | 3577 | console.error: PushService: 13:51:52 INFO - PROCESS | 3577 | stateChangeProcessEnqueue: Error transitioning state 13:51:52 INFO - PROCESS | 3577 | UnknownError 13:51:53 INFO - TEST-INFO | 3577: exit 0 13:51:53 INFO - Browser initialized. 13:51:53 INFO - Running cycle 1/1 for kraken test... 13:51:53 INFO - TEST-INFO | started process 3657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lj55P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:05 INFO - PROCESS | 3657 | RSS: Main: 157794304 13:52:05 INFO - PROCESS | 3657 | 13:52:07 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55439/tests/kraken/driver.html?testName=audio-beat-detection) 13:52:08 INFO - PROCESS | 3657 | RSS: Main: 215769088 13:52:08 INFO - PROCESS | 3657 | 13:52:11 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55439/tests/kraken/driver.html?testName=audio-dft) 13:52:12 INFO - PROCESS | 3657 | RSS: Main: 201302016 13:52:12 INFO - PROCESS | 3657 | 13:52:15 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55439/tests/kraken/driver.html?testName=audio-fft) 13:52:16 INFO - PROCESS | 3657 | RSS: Main: 269975552 13:52:16 INFO - PROCESS | 3657 | 13:52:18 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55439/tests/kraken/driver.html?testName=audio-oscillator) 13:52:18 INFO - PROCESS | 3657 | RSS: Main: 180264960 13:52:18 INFO - PROCESS | 3657 | 13:52:21 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55439/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:21 INFO - PROCESS | 3657 | RSS: Main: 183848960 13:52:21 INFO - PROCESS | 3657 | 13:52:25 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55439/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:25 INFO - PROCESS | 3657 | RSS: Main: 220983296 13:52:25 INFO - PROCESS | 3657 | 13:52:29 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55439/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:29 INFO - PROCESS | 3657 | RSS: Main: 216203264 13:52:29 INFO - PROCESS | 3657 | 13:52:32 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55439/tests/kraken/driver.html?testName=json-parse-financial) 13:52:33 INFO - PROCESS | 3657 | RSS: Main: 219066368 13:52:33 INFO - PROCESS | 3657 | 13:52:34 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55439/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:35 INFO - PROCESS | 3657 | RSS: Main: 209121280 13:52:35 INFO - PROCESS | 3657 | 13:52:37 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:38 INFO - PROCESS | 3657 | RSS: Main: 210915328 13:52:38 INFO - PROCESS | 3657 | 13:52:40 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:41 INFO - PROCESS | 3657 | RSS: Main: 219369472 13:52:41 INFO - PROCESS | 3657 | 13:52:43 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:44 INFO - PROCESS | 3657 | RSS: Main: 223256576 13:52:44 INFO - PROCESS | 3657 | 13:52:47 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:47 INFO - PROCESS | 3657 | RSS: Main: 221261824 13:52:47 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | Cycle 1(1): loaded http://localhost:55439/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55439/tests/kraken/driver.html?testName=ai-astar) 13:52:49 INFO - PROCESS | 3657 | RSS: Main: 263749632 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | __start_tp_report 13:52:49 INFO - PROCESS | 3657 | _x_x_mozilla_page_load 13:52:49 INFO - PROCESS | 3657 | _x_x_mozilla_page_load_details 13:52:49 INFO - PROCESS | 3657 | |i|pagename|runs| 13:52:49 INFO - PROCESS | 3657 | |0;ai-astar;114;110;115;112;113;112;112;113;113;113 13:52:49 INFO - PROCESS | 3657 | |1;audio-beat-detection;160;133;133;185;140;133;161;135;165;129 13:52:49 INFO - PROCESS | 3657 | |2;audio-dft;161;161;162;164;161;160;162;163;162;162 13:52:49 INFO - PROCESS | 3657 | |3;audio-fft;76;76;75;129;77;77;76;77;98;74 13:52:49 INFO - PROCESS | 3657 | |4;audio-oscillator;87;86;120;87;87;87;118;86;86;123 13:52:49 INFO - PROCESS | 3657 | |5;imaging-gaussian-blur;117;117;116;117;116;116;116;117;117;116 13:52:49 INFO - PROCESS | 3657 | |6;imaging-darkroom;146;147;146;147;146;148;148;148;147;148 13:52:49 INFO - PROCESS | 3657 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 13:52:49 INFO - PROCESS | 3657 | |8;json-parse-financial;62;62;62;63;63;67;62;76;61;62 13:52:49 INFO - PROCESS | 3657 | |9;json-stringify-tinderbox;65;65;65;65;66;64;65;65;66;67 13:52:49 INFO - PROCESS | 3657 | |10;stanford-crypto-aes;83;83;82;83;85;84;84;84;121;83 13:52:49 INFO - PROCESS | 3657 | |11;stanford-crypto-ccm;133;132;129;131;131;137;127;143;135;142 13:52:49 INFO - PROCESS | 3657 | |12;stanford-crypto-pbkdf2;169;169;173;170;167;169;168;172;167;167 13:52:49 INFO - PROCESS | 3657 | |13;stanford-crypto-sha256-iterative;68;69;66;67;70;66;67;65;70;68 13:52:49 INFO - PROCESS | 3657 | __end_tp_report 13:52:49 INFO - PROCESS | 3657 | __start_cc_report 13:52:49 INFO - PROCESS | 3657 | _x_x_mozilla_cycle_collect,1878 13:52:49 INFO - PROCESS | 3657 | __end_cc_report 13:52:49 INFO - PROCESS | 3657 | __startTimestamp1465419169836__endTimestamp 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | ------- Summary: start ------- 13:52:49 INFO - PROCESS | 3657 | Number of tests: 14 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.33 13:52:49 INFO - PROCESS | 3657 | Values: 114.0 110.0 115.0 112.0 113.0 112.0 112.0 113.0 113.0 113.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:150.00 stddev:18.96 (12.6%) stddev-sans-first:19.56 13:52:49 INFO - PROCESS | 3657 | Values: 160.0 133.0 133.0 185.0 140.0 133.0 161.0 135.0 165.0 129.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 13:52:49 INFO - PROCESS | 3657 | Values: 161.0 161.0 162.0 164.0 161.0 160.0 162.0 163.0 162.0 162.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:17.44 (22.8%) stddev-sans-first:18.29 13:52:49 INFO - PROCESS | 3657 | Values: 76.0 76.0 75.0 129.0 77.0 77.0 76.0 77.0 98.0 74.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.50 stddev:16.36 (18.9%) stddev-sans-first:16.97 13:52:49 INFO - PROCESS | 3657 | Values: 87.0 86.0 120.0 87.0 87.0 87.0 118.0 86.0 86.0 123.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:52:49 INFO - PROCESS | 3657 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 13:52:49 INFO - PROCESS | 3657 | Values: 146.0 147.0 146.0 147.0 146.0 148.0 148.0 148.0 147.0 148.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:52:49 INFO - PROCESS | 3657 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:62.50 stddev:4.52 (7.2%) stddev-sans-first:4.74 13:52:49 INFO - PROCESS | 3657 | Values: 62.0 62.0 62.0 63.0 63.0 67.0 62.0 76.0 61.0 62.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:52:49 INFO - PROCESS | 3657 | Values: 65.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 66.0 67.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:83.50 stddev:11.91 (14.3%) stddev-sans-first:12.53 13:52:49 INFO - PROCESS | 3657 | Values: 83.0 83.0 82.0 83.0 85.0 84.0 84.0 84.0 121.0 83.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.00 stddev:5.29 (3.9%) stddev-sans-first:5.60 13:52:49 INFO - PROCESS | 3657 | Values: 133.0 132.0 129.0 131.0 131.0 137.0 127.0 143.0 135.0 142.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.00 stddev:2.08 (1.2%) stddev-sans-first:2.20 13:52:49 INFO - PROCESS | 3657 | Values: 169.0 169.0 173.0 170.0 167.0 169.0 168.0 172.0 167.0 167.0 13:52:49 INFO - PROCESS | 3657 | 13:52:49 INFO - PROCESS | 3657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.81 13:52:49 INFO - PROCESS | 3657 | Values: 68.0 69.0 66.0 67.0 70.0 66.0 67.0 65.0 70.0 68.0 13:52:49 INFO - PROCESS | 3657 | -------- Summary: end -------- 13:52:49 INFO - PROCESS | 3657 | 13:52:50 INFO - TEST-INFO | 3657: exit 0 13:52:50 INFO - TEST-OK | kraken | took 63559ms 13:52:50 INFO - SUITE-END | took 1185s 13:52:50 INFO - Completed test suite (00:19:45) 13:52:50 INFO - javascript benchmark 13:52:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.8663066846657, 2684.1008262232153, 2693.8383696978176, 2714.6199532065502, 2729.304027472995, 4625.699329543586, 4704.0356726871, 4752.786124624392, 4810.278458231267, 4846.0307938412325, 4721.811127554894, 4741.668083234175, 4746.359241502396, 4792.065547218293, 4802.159622066142, 4395.318725597522, 4406.47122345319, 4417.0, 4430.047539778947, 4434.1575100730915, 4381.561843815625, 4475.261581839009, 4484.1928452878465, 4503.752293623849, 4530.524294949032, 4418.756968366739, 4463.977680111611, 4470.530594287602, 4482.350059241408, 4509.954900451003, 4225.598568136023, 4310.762908040057, 4338.370936214231, 4354.150940566591, 4396.736195828228, 4330.761808100553, 4372.256716358227, 4378.299472084483, 4383.605475507188, 4413.426254586915, 4693.55411235932, 4723.244280915072, 4724.0, 4730.243161094243, 4744.478107408182, 4903.166461701519, 4990.725510096943, 5090.618203634742, 5135.768890399941, 5192.61055420845, 5134.743262836881, 5145.76844042019, 5174.275601415805, 5190.351206099238, 5205.869853253661, 4659.138059459011, 4751.809927602926, 4756.643251756063, 4772.76136193189, 4801.015791762715, 5133.25567792668, 5224.216367544898, 5239.973800130975, 5245.659032162897, 5312.707801070901, 5029.06962211992, 5064.645474816727, 5077.390713114376, 5081.517255860687, 5084.237364395371, 4921.163402221631, 5072.898542029138, 5163.586913046947, 5168.966206758663, 5176.792928282826, 5034.647574669812, 5050.873728156752, 5055.873603159876, 5072.82245121419, 5100.903305789273, 5022.522860328336, 5033.295338652591, 5038.067957427887, 5078.162103252996, 5087.949120508822, 4225.281702110648, 4260.957390426118, 4297.656187504992, 4344.3483477478, 4392.802323895432, 3747.2880152770886, 3761.830717617659, 3769.26499332633, 3798.0, 3824.4072168813877, 4338.978305108518, 4349.304111342233, 4350.129974005148, 4378.5183629800695, 4390.780460976938, 4971.776270067856, 5032.270320803463, 5047.16721740916, 5114.207297868837, 5140.717260550706, 4317.762523061262, 4320.567943205654, 4345.608895199384, 4350.73895566267, 4358.411614432074, 4541.273396256649, 4557.065801510682, 4558.521355257651, 4562.543745625478, 4607.608353289941, 4693.882652933567, 4774.856754297377, 4808.206645903527, 4809.759512024455, 4839.0, 5118.590512758896, 5146.485351464824, 5176.1200595898035, 5198.116320225495, 5204.37547494288, 4868.050730107595, 4878.438979517401, 4880.536349046835, 4880.536349046835, 4890.510948905081, 4913.0, 4954.826581069789, 4982.0, 5010.348654674869, 5026.632315199456, 5075.492450754895, 5077.111505486451, 5077.2637967493765, 5095.617828662791, 5119.411267704261, 4929.186684197068, 4942.851714448572, 4944.579710724629, 4945.0, 4984.7258400788305, 4795.6163506918665, 4903.068417000758, 4962.925556116589, 4993.151164302005, 4995.900081998412, 4859.271109333628, 4895.094407534618, 4934.679245849008, 4938.827141050046, 4939.97530012362, 4862.805487780449, 5027.095122877917, 5035.647504674637, 5042.873928151826, 5073.543381095719, 4864.148773964613, 4905.877353066202, 4933.925991110064, 4937.728424936519, 4952.678075925053], "value": 4681.884691208292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.5650992226062, 591.464724424396, 598.9371116032817, 599.0744300056413, 607.0529973241742, 27896.581551276722, 30680.232994175156, 30892.84553577229, 40141.19717605646, 41232.58767412325, 38613.613863861356, 39016.21967560654, 39045.41431878524, 39045.804770976174, 39116.608833911654, 7733.0720313562315, 7915.4063445241545, 7917.089534703525, 7917.247861453182, 7923.2869041786225, 7671.539707617533, 7793.8051548711455, 7796.844063118734, 7801.0, 7806.024246969129, 7801.180876008023, 7864.960675196616, 7865.174156713549, 7866.567338796364, 7866.68533258669, 7795.883061754078, 7833.686652533892, 7851.097123830776, 7852.057753069668, 7852.175521570267, 7741.651625676858, 7839.1768864269, 7841.411894107965, 7842.058952925629, 7843.294103530652, 38449.80775096134, 38890.416643750366, 38891.80554097211, 38912.41631375532, 38925.0, 2854.200823769348, 3065.432894914448, 3110.891118810831, 3345.6654334566592, 3629.6551827576336, 26490.205293841216, 26777.330566735793, 29289.0, 29797.70202297971, 30037.249068773235, 3374.8143852088124, 3438.415469370213, 3526.312369088029, 3530.287810411948, 3531.9293614127832, 235454.0, 235643.99999999828, 236669.0, 236700.0, 238261.0, 31184.41379241371, 32485.837570812466, 52499.21251181235, 52502.0, 52583.0, 33426.665733342845, 33427.331453370796, 33437.83281083579, 33585.328293433995, 33635.32729345448, 13732.794008089886, 13860.653483662787, 13870.653233669038, 13890.861091389159, 13890.930545347208, 10261.281710280358, 10280.588776448858, 10281.897181028244, 10285.28003039795, 10318.587256509656, 7926.564038977796, 7944.761657150295, 7960.960195198987, 8010.639521221559, 8029.919700803034, 3065.0804758572785, 3089.7528197744577, 3099.9380012399624, 3162.098801841464, 3180.904572862818, 926.1340646495548, 967.7193613852045, 970.3751352591224, 1007.8387458006683, 1043.634727845248, 27169.456610867674, 27275.727242727717, 27309.180724578295, 27445.58831617527, 27812.0, 929.7257309093834, 1027.1012863744224, 1034.2966782587912, 1036.108946306176, 1081.6160263106642, 14652.413903443743, 14675.92662036683, 14727.116373017654, 14885.404583816742, 14966.850331496546, 303581.0, 304677.0, 305982.0, 306236.0, 307284.0, 48477.0, 48900.0, 48976.26535601897, 48978.75510622424, 48991.51008489869, 1090.9563617455372, 1141.0643272516456, 1169.7660467906453, 1234.9073819463397, 1238.8203710461933, 27605.30986725348, 29293.70706292995, 29663.85168074146, 29726.702732972393, 30114.849425753608, 43129.784351079295, 43503.56496434995, 43617.34573981456, 43675.56324436715, 43702.78148609237, 285365.0, 288917.0, 289971.0, 291048.0, 291130.0, 21314.467138321044, 23179.0, 25630.871845640653, 25694.614580781676, 26086.217413477625, 42334.57665423306, 42564.57435425606, 42828.78585607052, 43516.34725479057, 43540.0, 34901.0, 36562.0, 37091.0, 37175.0, 37469.81265093657, 36105.638943610225, 36321.27357452889, 36601.117843032334, 36667.63332366642, 37190.44214336733, 30846.845765771028, 35508.467372989944, 35893.461598075526, 36738.08154796151, 36817.07957301089, 30439.84780076174, 32927.835360824, 33365.49951750774, 33635.66364336325, 33737.493937590465, 24708.629370559815, 25334.619980699936, 25374.492510149325, 25515.6172657414, 25756.356091097125], "value": 16244.960595646782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3681268218664, 369.88348670168875, 370.24839575661406, 378.9071677439028, 379.78352339166685, 15454.61363465914, 17060.488185354458, 17121.22954467049, 17499.737503937453, 17654.0, 15903.44337948172, 16588.917055414735, 17247.31010759568, 17255.568610784736, 17272.481825545223, 4734.90530189396, 4887.0225954809, 4890.339804126451, 5084.084864724348, 5103.770330335144, 3682.1346983458866, 5002.899942001158, 5679.517241034517, 5984.7306871190685, 6004.0693692477735, 5926.644401335933, 5929.940700593003, 5946.137810017545, 5947.375525569796, 5953.58324917256, 5840.153177789197, 5882.264716910387, 5964.940350596504, 5965.403459654043, 5997.970010149921, 3327.2513684421056, 4862.708237505761, 5163.380394352665, 5176.50823171798, 5241.528262456397, 19782.50543736418, 20379.388618341327, 20397.592048159102, 20725.0, 20739.68890466629, 1929.411529483507, 1988.9005549722456, 2025.2405347994502, 2216.6342553478657, 2289.7252329720372, 12863.871361286454, 12877.162984406077, 12932.935335323264, 13089.738205235937, 13312.800307995389, 1712.3150739704095, 1755.5172327609882, 1762.118940529735, 1774.7480970646036, 1780.4836597386743, 61787.0, 62311.688441557955, 62976.37023629751, 63430.68284658547, 64066.679666601834, 8210.343172546181, 8665.74002779905, 8833.558322083998, 8950.328725345495, 9039.593218305192, 11857.407129643656, 11873.584424545099, 11902.40487975615, 11929.522819087313, 11960.760784784256, 6908.965455172793, 7095.751648692271, 7123.465740069516, 7224.169220539705, 7231.3130252625915, 7043.718251269995, 7085.50401471892, 7185.101862267216, 7206.279372062857, 7241.5293005954445, 3675.7243206759067, 3686.4654625079215, 3736.1033351995325, 3753.3431649461236, 3834.9041273968373, 1600.311671186909, 1682.3354774864106, 1766.3287950578697, 1825.963480730378, 1834.9816501835078, 387.0536538164218, 388.2642392665882, 391.8648066417081, 410.06914304528556, 818.9303909167668, 9957.651482198233, 9996.800063998824, 10252.58989640421, 10371.274010819321, 10501.737456563495, 397.73351854257714, 399.1358708396347, 402.915387768566, 413.3881854854832, 414.1137964755426, 5372.328458942632, 5421.647592906527, 5422.240886275925, 5560.666360018412, 5635.239242702265, 381732.0, 386130.0, 386422.0, 393331.0, 397590.0, 50723.23915141276, 51754.48245517497, 53350.7332463343, 79526.60236698895, 84487.5775621118, 414.3515398401492, 420.74544900334854, 421.4605305209337, 422.16832839306517, 423.5214207945064, 9467.715968520955, 9484.95257523708, 9604.95197524008, 9658.951705241428, 9840.360376575785, 33927.0, 34103.0, 34756.65243347534, 34852.0, 35969.64030359663, 49235.26147107868, 49727.502724972284, 49742.25386619276, 49931.50068499269, 50158.247626286364, 7424.183339832722, 7649.885251721117, 7709.2290770922455, 7709.9614501927135, 7827.882581761164, 11381.886181138414, 11537.596184133516, 11738.119641026786, 11745.647630571097, 11939.701507462383, 9755.951220244136, 9763.316567840184, 9893.802123957337, 10012.899871001197, 10138.294895879037, 9069.093090690878, 9097.636094556143, 10244.282900196915, 10279.53742081623, 10519.712637097064, 10012.799744004933, 10094.394336339843, 10108.0, 10355.689329320132, 10439.321444106108, 7382.483226174331, 7460.515066520658, 7612.3910087194, 7671.002769639911, 7724.304812566671, 9061.365704400629, 10209.489525523546, 10221.74445638865, 10229.232807539613, 10298.116428160256], "value": 7310.727258577992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.5127775806322, 1380.8342998840137, 1450.7606244969577, 1522.9314680839361, 1736.3228340947032, 6736.191657001161, 7607.353374963128, 7850.0579930408285, 7852.489588176764, 8046.275835174833, 7743.690252389912, 7906.683732650701, 7918.406119541029, 7922.0, 7922.3266022388025, 1830.560665440298, 1888.5089876632105, 1889.8582606304512, 2185.2242453928825, 2219.7447293561286, 1944.6596845552042, 2164.545445456456, 2227.3652009177385, 2228.0642130305228, 2252.2680128958073, 2161.1139432832542, 2169.327508472371, 2180.029886700419, 2188.5732282204976, 2195.6157672407344, 1782.465260421881, 2134.583756167548, 2143.3141394753684, 2145.056175282886, 2150.2904041666293, 2044.5604195097976, 2103.368989303203, 2108.1778106538463, 2124.649432843579, 2125.08621292844, 7804.49270797402, 7829.530228186327, 7854.057513098408, 7858.724944626968, 7875.212478752136, 4331.155424692186, 4468.173387923244, 4470.687051906368, 4470.955290447087, 4479.686421950465, 2754.986225068882, 2832.3344014156655, 2875.252434367059, 2908.243856597279, 2916.4458752836895, 890.679355432044, 891.2558014058269, 916.8441364967971, 919.0350132360994, 921.4333185091187, 10411.219158563063, 10415.479226038668, 10417.427041512714, 10423.791524169474, 10429.0, 4231.703780735319, 4242.215190189825, 4343.630791382768, 4351.499577548622, 4355.760433176142, 9144.497052662035, 9150.816983660423, 9160.541972901328, 9161.541922903829, 9171.495567743837, 4608.400907882021, 4612.400387949545, 4613.677042606985, 4618.49196588375, 4618.838340658061, 3609.1338078860886, 3630.9373311321897, 4091.2022155679356, 4186.644135248538, 4216.30430978885, 3576.4277715565386, 3705.4256590228556, 3785.5078839750654, 3825.6365645263654, 3838.6353296436796, 1150.6375491720082, 1160.808466603001, 1172.8709841917553, 1180.2564384437921, 1184.579474286633, 726.2084328082416, 781.9765407037798, 786.390547325827, 792.0495405513407, 807.9192080791992, 5223.085959956992, 5238.345206849144, 5254.947450525446, 5390.407055223922, 5390.730463476811, 384.50782997762906, 412.2846860696689, 419.0403974897451, 420.0884081543059, 421.62896650947584, 3464.3764122457696, 3471.3057388522398, 3515.876944306937, 3543.5216245807, 3562.1450851795385, 9166.312526560534, 9846.163076138608, 9870.407775533347, 9906.851397229048, 9972.351797133164, 9625.807483850283, 9816.852747208797, 9874.308798384043, 9893.406395616286, 9918.900810991941, 7499.175090740015, 7544.094708634889, 7592.696292148252, 7593.240675932473, 7600.3539699126195, 5130.666506677203, 5138.177891537336, 5139.254808052886, 5266.210068489757, 5296.073187192303, 9070.410423322463, 9070.81858362816, 9197.172254497127, 9204.355695101278, 9218.677346292847, 9032.63869445215, 9372.109649583279, 9482.099200575934, 9488.715338539854, 9505.144536991704, 5888.4700376966275, 6102.6643534604245, 6669.833254168685, 6685.364890335605, 6741.52809303344, 7196.604186769778, 7471.701131954661, 7487.438442116972, 7489.775306740807, 7496.662650180864, 6429.4534964526665, 6746.460283177236, 6752.69612867432, 6773.288804675438, 6808.217055038536, 6563.113979612691, 6589.769358072444, 6636.502262330441, 6660.467162626881, 6685.164354455693, 5925.05199168131, 5995.730192141451, 6003.489703375262, 6006.549508786946, 6041.033434650435, 4384.780760961876, 4469.0, 4555.430571178603, 4561.471906911222, 4584.312353147055, 4371.9344209836245, 4400.1199760047475, 4409.691321607456, 4511.774411279489, 4529.411176547028], "value": 4012.8868591869805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7251728409863, 303.95136778115506, 308.2140541618872, 312.0311433000535, 313.96546379898206, 4800.183968725316, 4823.228283474645, 4823.662343635947, 4843.685160464567, 4856.951430485694, 4798.592119669832, 4806.158922188621, 4814.0, 4828.661993660445, 4829.589484893788, 3621.1128273573013, 3707.2214834884708, 3722.906927326825, 3728.6457786510373, 3729.142297271629, 3616.2044350242904, 3742.251549690059, 3802.258559580883, 3822.140018495844, 3877.0501227199375, 3735.981320093396, 3765.7363984521094, 3784.2431513697234, 3794.753341032838, 3811.218700166473, 3541.6635419635095, 3728.3714980938375, 3778.7732736035928, 3790.90522736931, 3800.90497737556, 3242.3515296940473, 3243.1567792373917, 3248.0580631616804, 3250.5449237106823, 3260.2990357073345, 4524.298733696282, 4531.297648864432, 4535.297028960516, 4547.20423925815, 4553.2942393929, 4208.705390622657, 4213.304804707251, 4213.5042060068845, 4228.4080228768, 4248.171606536726, 4708.270218116198, 4947.876303092416, 4958.528939750718, 4961.950380496185, 5039.294498770175, 3533.840977156034, 3534.68187863091, 3551.8756843510355, 3552.378333791602, 3574.857005719768, 5276.944611077762, 5313.495217954288, 5315.627906046579, 5323.653962492464, 5330.546903513167, 3572.0, 3635.8365323096355, 3647.2340808429994, 3651.302144502819, 3678.7240956928335, 3642.8724994625063, 3697.7781333120097, 3716.2753263113973, 3720.534933133358, 3724.776513409204, 4203.17162034516, 4232.153569286155, 4238.660907127422, 4264.957350426518, 4266.786660666954, 5018.741566295182, 5036.244563315532, 5041.8487445376695, 5043.87390315245, 5071.7971281149075, 1206.4148887789415, 1266.6136828267468, 1267.0623738433492, 1269.0165122030317, 1269.4795133995203, 787.8424315136881, 794.4716763352421, 800.9199080091944, 811.6388207247836, 826.2563692676518, 4227.471566054243, 4360.367746676714, 4393.923488745214, 4416.381706561084, 4426.1369033038245, 5196.662216955886, 5204.9219261711105, 5216.817411390583, 5221.869453263699, 5222.738863056832, 4411.580899814512, 4412.0955204183065, 4430.645548356124, 4431.977840110779, 4436.402894957812, 2538.2765911715073, 2741.7943654226015, 2753.2428582140074, 2757.7104404037686, 2763.557830747111, 4890.119778439844, 4891.486393928657, 4899.534544218365, 4909.1654418748185, 4923.433805112386, 5059.443461219263, 5313.468653134656, 5326.280952071498, 5340.172273297645, 5365.195220716923, 4895.265710143436, 4895.947371315042, 4897.338859254026, 4923.359963204761, 4923.90152196954, 5181.481851814789, 5198.610104242272, 5206.921896171636, 5211.609129315392, 5226.189940559219, 4904.435989861212, 5037.974810125926, 5115.56517696, 5132.871678208075, 5134.306868572695, 4874.2201247800185, 4903.632227583017, 4912.813797859918, 4915.967646794214, 4920.507949205051, 3645.216278500135, 3654.744167908221, 3694.3534881395112, 3709.5548534176073, 3714.832832522597, 4927.679700819435, 5235.214717792209, 5247.55395791362, 5250.212468129811, 5267.73661316925, 5027.899442011066, 5043.2687260347775, 5058.595312375075, 5061.898762024813, 5064.82273120439, 5006.624503162205, 5016.799328026984, 5025.296458495886, 5048.334049763643, 5049.823256186163, 4726.125666751662, 4901.58336541398, 4940.901181976412, 4955.5044495550155, 4956.925646115384, 4768.189407800613, 4921.68680720061, 5027.899442011212, 5034.874128146826, 5040.42035165946, 4925.975370123127, 4964.25536169563, 4971.477994810638, 4987.750612469435, 4990.775415106402], "value": 3780.9871832743747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.3435868745352, 716.5628966330537, 722.94577906657, 723.7611588175903, 750.5909279442703, 11608.187426880122, 12258.448369823356, 12267.0, 12348.382580870943, 12375.257484550912, 12142.757144857098, 12146.514139434434, 12192.024638028959, 12209.08431867609, 12214.32821194834, 619.9287081985561, 768.3507436216388, 770.9845803083921, 785.305005070511, 793.5318162284251, 775.1163673412315, 775.2789905387987, 778.8286576953061, 780.0678189563474, 780.336713793274, 837.937154713399, 841.1378337204353, 841.2176675691604, 841.3479553346175, 841.8063845315581, 661.3221448015798, 813.7762115418249, 835.8704400817852, 836.8995720513517, 837.6021389839777, 575.8099827057061, 575.9798407055733, 577.2553406106118, 577.3447137498927, 594.7531774313654, 12838.229706217564, 12913.935430322883, 12920.935395323057, 12930.612081637566, 12932.224066555942, 12620.495180192873, 13321.13412628176, 13377.66555836102, 13394.665133371645, 13458.192508449427, 10524.210684198715, 10824.67525974222, 10848.457577121191, 10903.236773425864, 11201.719957001058, 3371.898843034713, 3392.490341797901, 3393.6776006279365, 3430.8627654893776, 3445.707114895212, 58259.70870145622, 58512.41487585155, 59050.704746476425, 59763.40236597622, 59976.40023599752, 10781.568737250422, 10854.45727713611, 10951.726206844893, 10969.683637963495, 11051.834222486668, 20099.19603215884, 20110.0, 20132.59734805325, 20206.19175232974, 20268.89865550663, 6764.645662606775, 6905.689243983932, 6918.688659010357, 7152.964235178895, 7157.4274058075225, 3727.683146932487, 3817.4464702617965, 3823.5794062653085, 3825.6556909877686, 3861.768293902375, 2860.9284767880554, 3008.864601092956, 3009.0521485731924, 3013.472642287591, 3023.455777959988, 505.9443461219263, 525.5454032262065, 525.8369905329283, 530.6975024236149, 532.5739408473206, 445.6167695781625, 469.81911963894146, 475.46747642640463, 509.0785677922971, 511.3786749099787, 7396.4452666050265, 7421.851562968711, 7530.962345188349, 7544.698212071566, 7653.4642575020325, 429.35167896475923, 491.36368402917594, 502.50252250271967, 509.83757033962627, 527.9788808447619, 3563.55455568054, 3763.6989040876665, 3783.7162212834146, 3806.1436176859984, 3852.8651497197466, 58812.0, 60382.698086509285, 61043.69478152581, 61220.38779612147, 66177.66911165413, 53454.19818702723, 63002.0, 85551.57224213963, 85920.0, 87466.12533874706, 73159.63420182865, 73432.63283683547, 77150.22849771543, 77509.0, 77684.2231577677, 7300.926990730025, 7304.63476826146, 7336.7432139874845, 7516.962415188108, 7554.093508778982, 37703.0, 41116.58883411127, 42487.15025699407, 45783.77108114438, 48455.27317090317, 57993.71003144957, 59123.0, 60357.698211508665, 60369.698151508965, 60415.56259936627, 11291.153163512605, 11399.316041037564, 11447.198696091527, 11786.58746943853, 12025.338606376734, 11417.0, 11616.477258523555, 11619.477123529292, 12790.36048197605, 12866.614001579968, 10831.891681083403, 10934.890651093387, 11231.26996745209, 11515.53937842477, 11623.302601843916, 7994.440389172702, 8367.205115514016, 8591.570421479026, 8603.91396086031, 8613.181747733955, 10337.431441270803, 11063.944680276547, 11110.11119110453, 11112.111031117653, 11221.438928053727, 8834.734957951016, 9127.908720912706, 9251.814963700823, 9399.671011514563, 9867.11195992364, 8944.642214311354, 9525.90474095278, 9652.90347096548, 9668.126868711028, 9843.409395436296], "value": 6261.589010037792, "unit": "score"}], "name": "dromaeo_css", "value": 6125.601820169823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 133.0, 185.0, 140.0, 133.0, 161.0, 135.0, 165.0, 129.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 164.0, 161.0, 160.0, 162.0, 163.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 129.0, 77.0, 77.0, 76.0, 77.0, 98.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 120.0, 87.0, 87.0, 87.0, 118.0, 86.0, 86.0, 123.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 67.0, 62.0, 76.0, 61.0, 62.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 66.0, 67.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 83.0, 85.0, 84.0, 84.0, 84.0, 121.0, 83.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 129.0, 131.0, 131.0, 137.0, 127.0, 143.0, 135.0, 142.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 173.0, 170.0, 167.0, 169.0, 168.0, 172.0, 167.0, 167.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 67.0, 70.0, 66.0, 67.0, 65.0, 70.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1547.7999999999997, "alertThreshold": 2.0}]} 13:52:51 INFO - Return code: 0 13:52:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:52:51 ERROR - # TBPL SUCCESS # 13:52:51 INFO - Running post-action listener: _resource_record_post_action 13:52:51 INFO - ##### 13:52:51 INFO - ##### Finished run-tests step (success) 13:52:51 INFO - ##### 13:52:51 INFO - Running post-run listener: _resource_record_post_run 13:52:51 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7794688; Write bytes: 435429376; Read time: 2164; Write time: 375824 13:52:51 INFO - TinderboxPrint: CPU usage
13.1% 13:52:51 INFO - TinderboxPrint: I/O read bytes / time
7,794,688 / 2,164 13:52:51 INFO - TinderboxPrint: I/O write bytes / time
435,429,376 / 375,824 13:52:51 INFO - TinderboxPrint: CPU idle
8,344.3 (86.9%) 13:52:51 INFO - TinderboxPrint: CPU user
1,212.0 (12.6%) 13:52:51 INFO - TinderboxPrint: Swap in / out
0 / 0 13:52:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 76029952; Read time: 252; Write time: 72568 13:52:51 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6029312; Write bytes: 358825984; Read time: 1860; Write time: 303256 13:52:51 INFO - Running post-run listener: _upload_blobber_files 13:52:51 INFO - Blob upload gear active. 13:52:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:52:51 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 13:52:51 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:52:51 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:52:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:56 INFO - (blobuploader) - INFO - Done attempting. 13:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:56 INFO - (blobuploader) - INFO - Done attempting. 13:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:52:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:52:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:52:57 INFO - (blobuploader) - INFO - Done attempting. 13:52:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:52:57 INFO - Return code: 0 13:52:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:52:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:52:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bdd8c5552d8e481a25118d4af208be737071c0db93a922e8fe05036dc13845d4df6993375d5bc2ee16f2b850b6791ba36c17bed7e0e0713492391fb3d005d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e4cf46fdc2ab1dd15b889a0a1b2ef1ac927876d29b969703805bc3d9ae946f11732d8d8ff6c12fcf9d63194f600062288f01dd09a23993ccfa42a244196153", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314be3cb588daa0101414898a7a501c4e9a7960cecff556fdc75fb333de437c75cc9d15fd3f0337a663cb8910829e88e0382aba793103e49fa1fcabbd1cc75a9"} 13:52:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:52:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:52:57 INFO - Contents: 13:52:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bdd8c5552d8e481a25118d4af208be737071c0db93a922e8fe05036dc13845d4df6993375d5bc2ee16f2b850b6791ba36c17bed7e0e0713492391fb3d005d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e4cf46fdc2ab1dd15b889a0a1b2ef1ac927876d29b969703805bc3d9ae946f11732d8d8ff6c12fcf9d63194f600062288f01dd09a23993ccfa42a244196153", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314be3cb588daa0101414898a7a501c4e9a7960cecff556fdc75fb333de437c75cc9d15fd3f0337a663cb8910829e88e0382aba793103e49fa1fcabbd1cc75a9"} 13:52:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:52:57 INFO - Copying logs to upload dir... 13:52:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:52:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.862894 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-08 13:52:57.998895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 13:52:58.002956) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bdd8c5552d8e481a25118d4af208be737071c0db93a922e8fe05036dc13845d4df6993375d5bc2ee16f2b850b6791ba36c17bed7e0e0713492391fb3d005d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e4cf46fdc2ab1dd15b889a0a1b2ef1ac927876d29b969703805bc3d9ae946f11732d8d8ff6c12fcf9d63194f600062288f01dd09a23993ccfa42a244196153", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314be3cb588daa0101414898a7a501c4e9a7960cecff556fdc75fb333de437c75cc9d15fd3f0337a663cb8910829e88e0382aba793103e49fa1fcabbd1cc75a9"} build_url:https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/fkOzrWE8RoCShVvsMkdEhw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56bdd8c5552d8e481a25118d4af208be737071c0db93a922e8fe05036dc13845d4df6993375d5bc2ee16f2b850b6791ba36c17bed7e0e0713492391fb3d005d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9e4cf46fdc2ab1dd15b889a0a1b2ef1ac927876d29b969703805bc3d9ae946f11732d8d8ff6c12fcf9d63194f600062288f01dd09a23993ccfa42a244196153", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/314be3cb588daa0101414898a7a501c4e9a7960cecff556fdc75fb333de437c75cc9d15fd3f0337a663cb8910829e88e0382aba793103e49fa1fcabbd1cc75a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 13:52:58.029621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:52:58.030212) ========= 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=8887e36bb8e381bfd44124ac000001a8-1465417918.255290-1083165500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 13:52:58.111875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 13:52:58.112296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 13:52:58.112866) ========= ========= Total master_lag: 0.56 =========