builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1461916806.85 results: success (0) buildid: 20160429000449 builduid: 1c58c77b48524e148e00bd7df6b1df6d revision: 3e2e4184eeffe605002d06eca912050e88ec3e04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.852412) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.852879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.853211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.875533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.875877) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-29 01:00:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 7.94M=0.001s 2016-04-29 01:00:06 (7.94 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.981196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:06.981522) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:07.029945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:07.033335) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e2e4184eeffe605002d06eca912050e88ec3e04 --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 3e2e4184eeffe605002d06eca912050e88ec3e04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-29 01:00:07,105 truncating revision to first 12 chars 2016-04-29 01:00:07,105 Setting DEBUG logging. 2016-04-29 01:00:07,105 attempt 1/10 2016-04-29 01:00:07,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e2e4184eeff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 01:00:07,824 unpacking tar archive at: fx-team-3e2e4184eeff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963585 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:08.016287) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:08.016614) ========= script_repo_revision: 3e2e4184eeffe605002d06eca912050e88ec3e04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:08.017049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:08.017349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 01:00:08.033375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-29 01:00:08.033675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:00:08 INFO - MultiFileLogger online at 20160429 01:00:08 in /builds/slave/test 01:00:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:00:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:00:08 INFO - {'append_to_log': False, 01:00:08 INFO - 'base_work_dir': '/builds/slave/test', 01:00:08 INFO - 'blob_upload_branch': 'Fx-Team', 01:00:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:00:08 INFO - 'branch': 'Fx-Team', 01:00:08 INFO - 'buildbot_json_path': 'buildprops.json', 01:00:08 INFO - 'config_files': ('talos/mac_config.py',), 01:00:08 INFO - 'default_actions': ('clobber', 01:00:08 INFO - 'read-buildbot-config', 01:00:08 INFO - 'download-and-extract', 01:00:08 INFO - 'populate-webroot', 01:00:08 INFO - 'create-virtualenv', 01:00:08 INFO - 'install', 01:00:08 INFO - 'run-tests'), 01:00:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:00:08 INFO - 'download_minidump_stackwalk': True, 01:00:08 INFO - 'download_symbols': 'ondemand', 01:00:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:00:08 INFO - 'tooltool.py': '/tools/tooltool.py', 01:00:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:00:08 INFO - '/tools/misc-python/virtualenv.py')}, 01:00:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:00:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:00:08 INFO - 'installer_path': 'installer.exe', 01:00:08 INFO - 'log_level': 'info', 01:00:08 INFO - 'log_name': 'talos', 01:00:08 INFO - 'log_to_console': True, 01:00:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:00:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:00:08 INFO - 'opt_config_files': (), 01:00:08 INFO - 'pip_index': False, 01:00:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:08 INFO - 'cmd': ('bash', 01:00:08 INFO - '-c', 01:00:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:08 INFO - 'enabled': True, 01:00:08 INFO - 'halt_on_failure': False, 01:00:08 INFO - 'name': 'check_screen_resolution'},), 01:00:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:00:08 INFO - 'cmd': ('bash', 01:00:08 INFO - '-c', 01:00:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:00:08 INFO - 'enabled': True, 01:00:08 INFO - 'halt_on_failure': False, 01:00:08 INFO - 'name': 'check_screen_resolution'},), 01:00:08 INFO - 'run_cmd_checks_enabled': True, 01:00:08 INFO - 'sps_profile': False, 01:00:08 INFO - 'sps_profile_interval': 0, 01:00:08 INFO - 'suite': 'dromaeojs', 01:00:08 INFO - 'system_bits': '32', 01:00:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:00:08 INFO - 'title': 't-yosemite-r7-0158', 01:00:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:00:08 INFO - 'use_talos_json': True, 01:00:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:00:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:00:08 INFO - 'work_dir': 'build'} 01:00:08 INFO - ##### 01:00:08 INFO - ##### Running clobber step. 01:00:08 INFO - ##### 01:00:08 INFO - Running pre-action listener: _resource_record_pre_action 01:00:08 INFO - Running main action method: clobber 01:00:08 INFO - rmtree: /builds/slave/test/build 01:00:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:00:09 INFO - Running post-action listener: _resource_record_post_action 01:00:09 INFO - ##### 01:00:09 INFO - ##### Running read-buildbot-config step. 01:00:09 INFO - ##### 01:00:09 INFO - Running pre-action listener: _resource_record_pre_action 01:00:09 INFO - Running main action method: read_buildbot_config 01:00:09 INFO - Using buildbot properties: 01:00:09 INFO - { 01:00:09 INFO - "project": "", 01:00:09 INFO - "product": "firefox", 01:00:09 INFO - "script_repo_revision": "production", 01:00:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:00:09 INFO - "repository": "", 01:00:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:00:09 INFO - "buildid": "20160429000449", 01:00:09 INFO - "pgo_build": "False", 01:00:09 INFO - "basedir": "/builds/slave/test", 01:00:09 INFO - "buildnumber": 746, 01:00:09 INFO - "slavename": "t-yosemite-r7-0158", 01:00:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:00:09 INFO - "platform": "yosemite_r7", 01:00:09 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:00:09 INFO - "branch": "fx-team", 01:00:09 INFO - "repo_path": "integration/fx-team", 01:00:09 INFO - "revision": "3e2e4184eeffe605002d06eca912050e88ec3e04", 01:00:09 INFO - "stage_platform": "macosx64", 01:00:09 INFO - "builduid": "1c58c77b48524e148e00bd7df6b1df6d", 01:00:09 INFO - "slavebuilddir": "test" 01:00:09 INFO - } 01:00:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 01:00:09 INFO - Running post-action listener: _resource_record_post_action 01:00:09 INFO - ##### 01:00:09 INFO - ##### Running download-and-extract step. 01:00:09 INFO - ##### 01:00:09 INFO - Running pre-action listener: _resource_record_pre_action 01:00:09 INFO - Running main action method: download_and_extract 01:00:09 INFO - mkdir: /builds/slave/test/build/tests 01:00: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')]} 01:00:09 INFO - https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 01:00:10 INFO - Downloaded 1199 bytes. 01:00:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:00:10 INFO - Using the following test package requirements: 01:00:10 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:00:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 01:00:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 01:00:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'jsshell-mac.zip'], 01:00:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 01:00:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:00:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 01:00:10 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 01:00:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 01:00:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:00:10 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 01:00:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:10 INFO - https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:00:11 INFO - Downloaded 18124290 bytes. 01:00:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:00:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:00:14 INFO - Return code: 0 01:00:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:00:14 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')]} 01:00:14 INFO - https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:00:15 INFO - Downloaded 18124290 bytes. 01:00:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:00:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:00:19 INFO - Return code: 0 01:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:19 INFO - https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:00:20 INFO - Downloaded 10840145 bytes. 01:00:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:00:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:00:20 INFO - Return code: 0 01:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:20 INFO - https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 01:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 01:00:23 INFO - Downloaded 110272045 bytes. 01:00:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:00:23 INFO - mkdir: /builds/slave/test/properties 01:00:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:23 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:23 INFO - Contents: 01:00:23 INFO - build_url:https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:00:24 INFO - Running post-action listener: _resource_record_post_action 01:00:24 INFO - Running post-action listener: set_extra_try_arguments 01:00:24 INFO - ##### 01:00:24 INFO - ##### Running populate-webroot step. 01:00:24 INFO - ##### 01:00:24 INFO - Running pre-action listener: _resource_record_pre_action 01:00:24 INFO - Running main action method: populate_webroot 01:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:25 INFO - '--tppagecycles', 01:00:25 INFO - '7'], 01:00:25 INFO - 'tests': ['tsvgm']}}, 01:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['damp', 'tps']}, 01:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'tests': ['damp', 'tps']}, 01:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['dromaeo_dom']}, 01:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['a11yr', 01:00:25 INFO - 'ts_paint', 01:00:25 INFO - 'tpaint', 01:00:25 INFO - 'sessionrestore', 01:00:25 INFO - 'sessionrestore_no_auto_restore', 01:00:25 INFO - 'tabpaint']}, 01:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['tsvgx', 01:00:25 INFO - 'tsvgr_opacity', 01:00:25 INFO - 'tart', 01:00:25 INFO - 'tscrollx', 01:00:25 INFO - 'cart']}, 01:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:00:25 INFO - 'tsvgr_opacity', 01:00:25 INFO - 'tart', 01:00:25 INFO - 'tscrollx', 01:00:25 INFO - 'cart']}, 01:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'talos_options': ['--disable-e10s'], 01:00:25 INFO - 'tests': ['tp5o']}, 01:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'tests': ['tp5o']}, 01:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'talos_options': ['--disable-e10s', 01:00:25 INFO - '--xperf_path', 01:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:25 INFO - 'tests': ['tp5n']}, 01:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:25 INFO - 'talos_options': ['--xperf_path', 01:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:25 INFO - 'tests': ['tp5n']}}, 01:00:25 INFO - 'talos.zip': {'path': '', 01:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:25 INFO - Running post-action listener: _resource_record_post_action 01:00:25 INFO - ##### 01:00:25 INFO - ##### Running create-virtualenv step. 01:00:25 INFO - ##### 01:00:25 INFO - Running pre-action listener: _resource_record_pre_action 01:00:25 INFO - Running main action method: create_virtualenv 01:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00:25 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 01:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:25 INFO - Using real prefix '/tools/python27' 01:00:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:00:28 INFO - Installing pip.................done. 01:00:28 INFO - Return code: 0 01:00:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:00:28 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')]} 01:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 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')]} 01:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:28 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 01:00:28 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 01:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:28 INFO - 'HOME': '/Users/cltbld', 01:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:28 INFO - 'LOGNAME': 'cltbld', 01:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:28 INFO - 'MOZ_NO_REMOTE': '1', 01:00:28 INFO - 'NO_EM_RESTART': '1', 01:00:28 INFO - 'PAGER': '/bin/cat', 01:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:28 INFO - 'PWD': '/builds/slave/test', 01:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:28 INFO - 'SHELL': '/bin/bash', 01:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:28 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:28 INFO - 'USER': 'cltbld', 01:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:28 INFO - 'XPC_FLAGS': '0x0', 01:00:28 INFO - 'XPC_SERVICE_NAME': '0', 01:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:28 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 01:00:28 INFO - Cleaning up... 01:00:28 INFO - Return code: 0 01:00:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:00:28 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')]} 01:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 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')]} 01:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:28 INFO - 'HOME': '/Users/cltbld', 01:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:28 INFO - 'LOGNAME': 'cltbld', 01:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:28 INFO - 'MOZ_NO_REMOTE': '1', 01:00:28 INFO - 'NO_EM_RESTART': '1', 01:00:28 INFO - 'PAGER': '/bin/cat', 01:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:28 INFO - 'PWD': '/builds/slave/test', 01:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:28 INFO - 'SHELL': '/bin/bash', 01:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:28 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:28 INFO - 'USER': 'cltbld', 01:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:28 INFO - 'XPC_FLAGS': '0x0', 01:00:28 INFO - 'XPC_SERVICE_NAME': '0', 01:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:29 INFO - Downloading/unpacking psutil>=0.7.1 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:00:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:32 INFO - Installing collected packages: psutil 01:00:32 INFO - Running setup.py install for psutil 01:00:32 INFO - building 'psutil._psutil_osx' extension 01:00:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:00:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:00:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:00:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:00:32 INFO - building 'psutil._psutil_posix' extension 01:00:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:00:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:00:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:00:32 INFO - ^ 01:00:32 INFO - 1 warning generated. 01:00:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:00:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:33 INFO - Successfully installed psutil 01:00:33 INFO - Cleaning up... 01:00:33 INFO - Return code: 0 01:00:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:00: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')]} 01:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00: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')]} 01:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:33 INFO - 'HOME': '/Users/cltbld', 01:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:33 INFO - 'LOGNAME': 'cltbld', 01:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:33 INFO - 'MOZ_NO_REMOTE': '1', 01:00:33 INFO - 'NO_EM_RESTART': '1', 01:00:33 INFO - 'PAGER': '/bin/cat', 01:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:33 INFO - 'PWD': '/builds/slave/test', 01:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:33 INFO - 'SHELL': '/bin/bash', 01:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:33 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:33 INFO - 'USER': 'cltbld', 01:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:33 INFO - 'XPC_FLAGS': '0x0', 01:00:33 INFO - 'XPC_SERVICE_NAME': '0', 01:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:00:35 INFO - Installing collected packages: mozsystemmonitor 01:00:35 INFO - Running setup.py install for mozsystemmonitor 01:00:36 INFO - Successfully installed mozsystemmonitor 01:00:36 INFO - Cleaning up... 01:00:36 INFO - Return code: 0 01:00:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:36 INFO - 'HOME': '/Users/cltbld', 01:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:36 INFO - 'LOGNAME': 'cltbld', 01:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:36 INFO - 'MOZ_NO_REMOTE': '1', 01:00:36 INFO - 'NO_EM_RESTART': '1', 01:00:36 INFO - 'PAGER': '/bin/cat', 01:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:36 INFO - 'PWD': '/builds/slave/test', 01:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:36 INFO - 'SHELL': '/bin/bash', 01:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:36 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:36 INFO - 'USER': 'cltbld', 01:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:36 INFO - 'XPC_FLAGS': '0x0', 01:00:36 INFO - 'XPC_SERVICE_NAME': '0', 01:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:38 INFO - Downloading blobuploader-1.2.4.tar.gz 01:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00: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 01:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:00:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:39 INFO - Downloading docopt-0.6.1.tar.gz 01:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:00:40 INFO - Installing collected packages: blobuploader, requests, docopt 01:00:40 INFO - Running setup.py install for blobuploader 01:00:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:00:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:00:40 INFO - Running setup.py install for requests 01:00:40 INFO - Running setup.py install for docopt 01:00:40 INFO - Successfully installed blobuploader requests docopt 01:00:40 INFO - Cleaning up... 01:00:40 INFO - Return code: 0 01:00:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:40 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:40 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 01:00:40 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 01:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:40 INFO - 'HOME': '/Users/cltbld', 01:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:40 INFO - 'LOGNAME': 'cltbld', 01:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:40 INFO - 'MOZ_NO_REMOTE': '1', 01:00:40 INFO - 'NO_EM_RESTART': '1', 01:00:40 INFO - 'PAGER': '/bin/cat', 01:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:40 INFO - 'PWD': '/builds/slave/test', 01:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:40 INFO - 'SHELL': '/bin/bash', 01:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:40 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:40 INFO - 'USER': 'cltbld', 01:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:40 INFO - 'XPC_FLAGS': '0x0', 01:00:40 INFO - 'XPC_SERVICE_NAME': '0', 01:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-f8UUow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XOXa4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-8nMJ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-eASWfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pzhSqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-R4xmOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XXoFWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-vykGIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:41 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-qONLTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-WMAnrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-38aKsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-gTGlZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-NVYS79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-NC5wba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ATVUUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lG3HO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:42 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-azJphH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:42 INFO - Running setup.py install for manifestparser 01:00:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:43 INFO - Running setup.py install for mozcrash 01:00:43 INFO - Running setup.py install for mozdebug 01:00:43 INFO - Running setup.py install for mozdevice 01:00:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:43 INFO - Running setup.py install for mozfile 01:00:43 INFO - Running setup.py install for mozhttpd 01:00:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:43 INFO - Running setup.py install for mozinfo 01:00:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:43 INFO - Running setup.py install for mozInstall 01:00:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Running setup.py install for mozleak 01:00:44 INFO - Running setup.py install for mozlog 01:00:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Running setup.py install for moznetwork 01:00:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Running setup.py install for mozprocess 01:00:44 INFO - Running setup.py install for mozprofile 01:00:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:44 INFO - Running setup.py install for mozrunner 01:00:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:45 INFO - Running setup.py install for mozscreenshot 01:00:45 INFO - Running setup.py install for moztest 01:00:45 INFO - Running setup.py install for mozversion 01:00:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:45 INFO - Cleaning up... 01:00:45 INFO - Return code: 0 01:00:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:45 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')]} 01:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:45 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')]} 01:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:45 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:45 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 01:00:45 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 01:00:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:45 INFO - 'HOME': '/Users/cltbld', 01:00:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:45 INFO - 'LOGNAME': 'cltbld', 01:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:45 INFO - 'MOZ_NO_REMOTE': '1', 01:00:45 INFO - 'NO_EM_RESTART': '1', 01:00:45 INFO - 'PAGER': '/bin/cat', 01:00:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:45 INFO - 'PWD': '/builds/slave/test', 01:00:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:45 INFO - 'SHELL': '/bin/bash', 01:00:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:45 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:45 INFO - 'USER': 'cltbld', 01:00:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:45 INFO - 'XPC_FLAGS': '0x0', 01:00:45 INFO - 'XPC_SERVICE_NAME': '0', 01:00:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-xTXhCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:45 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)) 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-dprmI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:45 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)) 01:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:45 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-EDI7MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-PX8nIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-mdHixj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-VBtwV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-s9jVDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pI3vWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-agpwgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-HZg40d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lcqlYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:46 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)) 01:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:46 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-HlHS41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:47 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)) 01:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-UWd8PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:47 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)) 01:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-vjlYkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:47 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)) 01:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-o2EMQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:47 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)) 01:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-Q_KKqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:47 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)) 01:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:47 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-KVT_vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:47 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)) 01:00:47 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)) 01:00:47 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)) 01:00:47 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)) 01:00:47 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)) 01:00:47 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)) 01:00:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:47 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 01:00:47 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 01:00:47 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 01:00:47 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 01:00:47 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 01:00:47 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 01:00:49 INFO - Downloading blessings-1.6.tar.gz 01:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:50 INFO - Installing collected packages: blessings 01:00:50 INFO - Running setup.py install for blessings 01:00:50 INFO - Successfully installed blessings 01:00:50 INFO - Cleaning up... 01:00:50 INFO - Return code: 0 01:00:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:50 INFO - Reading from file tmpfile_stdout 01:00:50 INFO - Current package versions: 01:00:50 INFO - blessings == 1.6 01:00:50 INFO - blobuploader == 1.2.4 01:00:50 INFO - docopt == 0.6.1 01:00:50 INFO - manifestparser == 1.1 01:00:50 INFO - mozInstall == 1.12 01:00:50 INFO - mozcrash == 0.17 01:00:50 INFO - mozdebug == 0.1 01:00:50 INFO - mozdevice == 0.48 01:00:50 INFO - mozfile == 1.2 01:00:50 INFO - mozhttpd == 0.7 01:00:50 INFO - mozinfo == 0.9 01:00:50 INFO - mozleak == 0.1 01:00:50 INFO - mozlog == 3.1 01:00:50 INFO - moznetwork == 0.27 01:00:50 INFO - mozprocess == 0.22 01:00:50 INFO - mozprofile == 0.28 01:00:50 INFO - mozrunner == 6.11 01:00:50 INFO - mozscreenshot == 0.1 01:00:50 INFO - mozsystemmonitor == 0.0 01:00:50 INFO - moztest == 0.7 01:00:50 INFO - mozversion == 1.4 01:00:50 INFO - psutil == 3.1.1 01:00:50 INFO - requests == 1.2.3 01:00:50 INFO - wsgiref == 0.1.2 01:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:50 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')]} 01:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:50 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')]} 01:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:50 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:50 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 01:00:50 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 01:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:50 INFO - 'HOME': '/Users/cltbld', 01:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:50 INFO - 'LOGNAME': 'cltbld', 01:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:50 INFO - 'MOZ_NO_REMOTE': '1', 01:00:50 INFO - 'NO_EM_RESTART': '1', 01:00:50 INFO - 'PAGER': '/bin/cat', 01:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:50 INFO - 'PWD': '/builds/slave/test', 01:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:50 INFO - 'SHELL': '/bin/bash', 01:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:50 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:50 INFO - 'USER': 'cltbld', 01:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:50 INFO - 'XPC_FLAGS': '0x0', 01:00:50 INFO - 'XPC_SERVICE_NAME': '0', 01:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 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)) 01:00:50 INFO - Cleaning up... 01:00:50 INFO - Return code: 0 01:00:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:00:50 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')]} 01:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:50 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')]} 01:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:50 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:50 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 01:00:50 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 01:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:50 INFO - 'HOME': '/Users/cltbld', 01:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:50 INFO - 'LOGNAME': 'cltbld', 01:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:50 INFO - 'MOZ_NO_REMOTE': '1', 01:00:50 INFO - 'NO_EM_RESTART': '1', 01:00:50 INFO - 'PAGER': '/bin/cat', 01:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:50 INFO - 'PWD': '/builds/slave/test', 01:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:50 INFO - 'SHELL': '/bin/bash', 01:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:50 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:50 INFO - 'USER': 'cltbld', 01:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:50 INFO - 'XPC_FLAGS': '0x0', 01:00:50 INFO - 'XPC_SERVICE_NAME': '0', 01:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:51 INFO - Downloading/unpacking jsonschema 01:00:51 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 01:00:51 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 01:00:51 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 01:00:51 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 01:00:51 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 01:00:51 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 01:00:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:00:53 INFO - Downloading/unpacking functools32 (from jsonschema) 01:00:53 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 01:00:53 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 01:00:53 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 01:00:53 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 01:00:53 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 01:00:53 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 01:00:53 INFO - Downloading functools32-3.2.3-2.tar.gz 01:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:00:54 INFO - warning: no files found matching '*.txt' 01:00:54 INFO - no previously-included directories found matching 'build' 01:00:54 INFO - no previously-included directories found matching 'dist' 01:00:54 INFO - no previously-included directories found matching '.git*' 01:00:54 INFO - Installing collected packages: jsonschema, functools32 01:00:54 INFO - Running setup.py install for functools32 01:00:54 INFO - warning: no files found matching '*.txt' 01:00:54 INFO - no previously-included directories found matching 'build' 01:00:54 INFO - no previously-included directories found matching 'dist' 01:00:54 INFO - no previously-included directories found matching '.git*' 01:00:54 INFO - Successfully installed jsonschema functools32 01:00:54 INFO - Cleaning up... 01:00:54 INFO - Return code: 0 01:00:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:54 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 0x10ac54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa853d6b520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:00:54 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 01:00:54 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 01:00:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:00:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:00:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:00:54 INFO - 'HOME': '/Users/cltbld', 01:00:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:00:54 INFO - 'LOGNAME': 'cltbld', 01:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:54 INFO - 'MOZ_NO_REMOTE': '1', 01:00:54 INFO - 'NO_EM_RESTART': '1', 01:00:54 INFO - 'PAGER': '/bin/cat', 01:00:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:54 INFO - 'PWD': '/builds/slave/test', 01:00:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:00:54 INFO - 'SHELL': '/bin/bash', 01:00:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:00:54 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:00:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:00:54 INFO - 'USER': 'cltbld', 01:00:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:00:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:54 INFO - 'XPC_FLAGS': '0x0', 01:00:54 INFO - 'XPC_SERVICE_NAME': '0', 01:00:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:54 INFO - Downloading/unpacking flake8 01:00:54 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 01:00:54 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 01:00:54 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 01:00:54 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 01:00:54 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 01:00:54 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 01:00:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:00:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:00:56 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 01:00:56 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 01:00:56 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 01:00:56 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 01:00:56 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 01:00:56 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 01:00:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:00:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:58 INFO - no previously-included directories found matching 'docs/_build' 01:00:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:00:58 INFO - Running setup.py install for pep8 01:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:00:58 INFO - no previously-included directories found matching 'docs/_build' 01:00:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:00:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:00:58 INFO - Cleaning up... 01:00:58 INFO - Return code: 0 01:00:58 INFO - Running post-action listener: _resource_record_post_action 01:00:58 INFO - Running post-action listener: _start_resource_monitoring 01:00:58 INFO - Starting resource monitoring. 01:00:58 INFO - ##### 01:00:58 INFO - ##### Running install step. 01:00:58 INFO - ##### 01:00:58 INFO - Running pre-action listener: _resource_record_pre_action 01:00:58 INFO - Running main action method: install 01:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:58 INFO - Reading from file tmpfile_stdout 01:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:58 INFO - Reading from file tmpfile_stdout 01:00:58 INFO - Output received: 01:00:58 INFO - Usage: mozinstall [options] installer 01:00:58 INFO - Options: 01:00:58 INFO - -h, --help show this help message and exit 01:00:58 INFO - -d DEST, --destination=DEST 01:00:58 INFO - Directory to install application into. [default: 01:00:58 INFO - "/builds/slave/test"] 01:00:58 INFO - --app=APP Application being installed. [default: firefox] 01:00:58 INFO - mkdir: /builds/slave/test/build/application 01:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:01:32 INFO - Reading from file tmpfile_stdout 01:01:32 INFO - Output received: 01:01:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:01:32 INFO - Running post-action listener: _resource_record_post_action 01:01:32 INFO - ##### 01:01:32 INFO - ##### Running run-tests step. 01:01:32 INFO - ##### 01:01:32 INFO - Running pre-action listener: _resource_record_pre_action 01:01:32 INFO - Running main action method: run_tests 01:01:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:01:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:01:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:01:32 INFO - 2016-04-29 01:01:32.246 screenresolution[1980:13909] starting screenresolution argv=screenresolution get 01:01:32 INFO - 2016-04-29 01:01:32.249 screenresolution[1980:13909] Display 0: 1600x1200x32@60 01:01:32 INFO - 2016-04-29 01:01:32.255 screenresolution[1981:13911] starting screenresolution argv=screenresolution list 01:01:32 INFO - Available Modes on Display 0 01:01:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:01:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:01:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:01:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:01:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:01:32 INFO - Intel Iris: 01:01:32 INFO - Chipset Model: Intel Iris 01:01:32 INFO - Type: GPU 01:01:32 INFO - Bus: Built-In 01:01:32 INFO - VRAM (Dynamic, Max): 1536 MB 01:01:32 INFO - Vendor: Intel (0x8086) 01:01:32 INFO - Device ID: 0x0a2e 01:01:32 INFO - Revision ID: 0x0009 01:01:32 INFO - Displays: 01:01:32 INFO - Display: 01:01:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:01:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:01:32 INFO - Display Serial Number: 1600x1200 60 01:01:32 INFO - Main Display: Yes 01:01:32 INFO - Mirror: Off 01:01:32 INFO - Online: Yes 01:01:32 INFO - Rotation: Supported 01:01:32 INFO - Return code: 0 01:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:01:32 INFO - Python 2.7.3 01:01:32 INFO - Return code: 0 01:01:32 INFO - grabbing minidump binary from tooltool 01:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:01:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf3e00>, '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 0x10a91cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:01:32 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:01:32 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:01:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:01:32 INFO - Return code: 0 01:01:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:01:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:01:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:01:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:01:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:01:33 INFO - Return code: 0 01:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 01:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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 01:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IR8hdbXKo1/Render', 01:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:01:33 INFO - 'HOME': '/Users/cltbld', 01:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:01:33 INFO - 'LOGNAME': 'cltbld', 01:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:01:33 INFO - 'MOZ_NO_REMOTE': '1', 01:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:01:33 INFO - 'NO_EM_RESTART': '1', 01:01:33 INFO - 'PAGER': '/bin/cat', 01:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:01:33 INFO - 'PWD': '/builds/slave/test', 01:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:01:33 INFO - 'SHELL': '/bin/bash', 01:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners', 01:01:33 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 01:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:01:33 INFO - 'USER': 'cltbld', 01:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:01:33 INFO - 'XPC_FLAGS': '0x0', 01:01:33 INFO - 'XPC_SERVICE_NAME': '0', 01:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:01:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 01:01:33 INFO - mozversion application_buildid: 20160429000449 01:01:33 INFO - mozversion application_changeset: 3e2e4184eeffe605002d06eca912050e88ec3e04 01:01:33 INFO - mozversion application_display_name: Nightly 01:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:01:33 INFO - mozversion application_name: Firefox 01:01:33 INFO - mozversion application_remotingname: firefox 01:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:01:33 INFO - mozversion application_vendor: Mozilla 01:01:33 INFO - mozversion application_version: 49.0a1 01:01:33 INFO - mozversion platform_buildid: 20160429000449 01:01:33 INFO - mozversion platform_changeset: 3e2e4184eeffe605002d06eca912050e88ec3e04 01:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:01:33 INFO - mozversion platform_version: 49.0a1 01:01:33 INFO - using testdate: 1461916893 01:01:33 INFO - actual date: 1461916893 01:01:33 INFO - starting webserver on 'localhost:51349' 01:01:33 INFO - SUITE-START | Running 2 tests 01:01:33 INFO - TEST-START | dromaeo_css 01:01:33 INFO - operating with platform_type : mac_ 01:01:33 INFO - Initialising browser for dromaeo_css test... 01:01:33 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp3FYDMA/profile http://localhost:51349/getInfo.html) 01:01:36 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 01:01:36 INFO - PROCESS | 1999 | colorDepth:24 01:01:36 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 01:01:36 INFO - PROCESS | 1999 | __metrics 01:01:36 INFO - PROCESS | 1999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:01:36 ERROR - PROCESS | 1999 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:01:36 INFO - TEST-INFO | 1999: exit 0 01:01:36 INFO - Browser initialized. 01:01:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:01:36 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp3FYDMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:01:48 INFO - PROCESS | 2001 | RSS: Main: 239607808 01:01:48 INFO - PROCESS | 2001 | 01:02:40 INFO - PROCESS | 2001 | 1461916960155 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] 01:04:50 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51349/tests/dromaeo/cssquery-ext.html) 01:04:52 INFO - PROCESS | 2001 | RSS: Main: 359235584 01:04:52 INFO - PROCESS | 2001 | 01:07:54 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-ext.html (next: http://localhost:51349/tests/dromaeo/cssquery-jquery.html) 01:07:55 INFO - PROCESS | 2001 | RSS: Main: 376537088 01:07:55 INFO - PROCESS | 2001 | 01:10:57 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51349/tests/dromaeo/cssquery-mootools.html) 01:10:58 INFO - PROCESS | 2001 | RSS: Main: 370884608 01:10:58 INFO - PROCESS | 2001 | 01:14:00 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51349/tests/dromaeo/cssquery-prototype.html) 01:14:01 INFO - PROCESS | 2001 | RSS: Main: 371134464 01:14:01 INFO - PROCESS | 2001 | 01:17:04 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51349/tests/dromaeo/cssquery-yui.html) 01:17:05 INFO - PROCESS | 2001 | RSS: Main: 342372352 01:17:05 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51349/tests/dromaeo/cssquery-yui.html (next: http://localhost:51349/tests/dromaeo/cssquery-dojo.html) 01:20:08 INFO - PROCESS | 2001 | RSS: Main: 375898112 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | __start_tp_report 01:20:08 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 01:20:08 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 01:20:08 INFO - PROCESS | 2001 | |i|pagename|runs| 01:20:08 INFO - PROCESS | 2001 | |0;dojo.html;3134.639516455608;3373.342198271338;3387.0177648481936;3411.0960595442198;3447.7241820654335;5546.972265138679;5593.300837395325;5629;5646.661200327978;5660.207570940067;5584.162375643646;5606.803761868336;5611.579131565129;5678.744456499458;5685.943140568593;5075.467075957026;5113.335266415361;5126.077306084903;5145.768440420171;5269.65747226431;5232.3459567554055;5268.31511903452;5275.393329767087;5282.973585132069;5331.466853314657;5102.948970510284;5168.173092305251;5188.45521220274;5195.168772996302;5223.6343455958095;4328.4156638853665;5105.566026887719;5158.509941555546;5169.353830771153;5174.896502069938;5114.539691427753;5123.487651234884;5147.974260128675;5158.74206289684;5166.948330516684;5454.181872719124;5554.833354999357;5562.249096371978;5563.554915606742;5579.581531385163;4999.650024498286;6079.961675881735;6089.665068421235;6091.006450648836;6122.977604208165;6104.572679912408;6105.511559075263;6152.077188421727;6170.352113028157;6170.691465426711;5586.608937374426;5659.603827732019;5663.716814159276;5706.400827913092;5734.483896449298;6170.444659980623;6236.095766113979;6256.436920677161;6265.686715664198;6272.874542509125;6005.969970150121;6031.7587296507645;6040.033594624839;6044;6044.758209671564;6040.607360521552;6113.32753397126;6134.38656134383;6180.4437600615265;6187.628742275478;6060.939390606038;6100.702285529923;6101.095933926299;6110.558759196641;6121.755129794758;6123.817328466031;6137.478314343331;6140.662263575547;6146.846328841725;6147.44672979425;4783.425988881357;4810.831620893252;4843.104025755247;4848.466668666444;4907.730074845917;4290.399344091829;4309.461317335333;4324.762138082436;4344.913101737948;4346.391505189276;5426;5441.537469315073;5441.727913604304;5447.1829225616475;5455.263539422207;5854.795082172103;5887.058070708752;5933.614315069507;5940.61386009908;5957.076653118774;5562.332520097533;5616.129499927518;5651.491365777099;5656.321241451053;5671.291088613923;5323.680579165262;5331.173668081454;5333.7866485340155;5341.305630268041;5365.490278423544;5973.910391344047;6203.4416902479;6229;6246.312905580292;6253.530985176039;6077.604955677867;6101.816945491642;6141.424638644238;6155.076738489083;6201.410865967726;6204.534659900616;6212.409821067172;6227.314995350417;6229.190205273286;6254.906176407267;6083.726232319467;6115.296740874856;6121.418465245794;6128.387161283836;6134.938650613437;5385.6230063895155;5840.795572155124;6044.7279872406725;6109.586862300561;6125.203723515914;5861.501772349398;5872.735726892215;5877.147813566923;5904.645721256738;5905.350411454822;5809.390014048633;5846.503047241032;5856.385079566584;5867.119932010062;5867.765289388377;5728.484436400744;5752.884942301214;5770;5783.3638299787835;5807.94192058074;5993.850153746017;6016.789412370546;6037.45662890342;6058.242719660043;6086.969565152146;5747.3103227612955;5860.120981852756;5878.118282257696;5899.823005309848;5902.61632993854 01:20:08 INFO - PROCESS | 2001 | |1;ext.html;531.1050879268433;533.8318429694647;583.9445252700993;590.3948452835846;621.5711159300082;30851;31310.373792524137;38858.11418858113;39552;39648;44425.7778711106;45056.774716126376;45087.32369014459;45100;45235;9593.808123837536;9841.21270298378;9846.852297215548;9849.803003939916;9878.851817222747;9675.322727409084;9854.90145098547;9856.802863942718;9857.852132218022;9891.752706182331;9850.261230407712;9913.900860991405;9924.45415502147;9945.701628951107;9947.253955953296;9819.705408837746;9883.604655813831;9884.258680598983;9892.604295828158;9900.50497475127;9635.98822123681;9731.172850307732;9768.560414781352;9783.168430683401;9784.510774461249;41230;41521;41540.58459415428;41582.58417415847;41673.79163104165;3218.5976752905885;3235.7573182011442;3245.237369218232;3435.1068722132177;3666.138457462494;25145;25484.617730734055;25520.48959020828;26100.60849087265;26129.73870261311;2746.32714984828;2755.3800394911186;2786.5680819473014;2848.330642299058;2868.698786627395;460443;461904;462355;462768.68615656707;463683.6815815933;32802.83598581992;58781.118283225784;60095;60271.69864150739;60292.698536507036;34746;34780.30439391198;34851.825740871136;34905.30189396249;35084.29831403358;15385.769213461806;15527.922360388351;15656.530304090895;15682.68634627301;15702.921485392728;13036;13124.606261812161;13135.080544361994;13145.145565538209;13183.945284377418;8204.671813127527;8209.38429617781;8234.629441675139;8287.461315014505;8324.209200125979;3356.2280675444295;3388.711959483422;3406.114410253352;3417.829108544563;3418.8461519231696;966.6181858165985;983.829243200589;1036.290141253229;1056.7410984308895;1119.35467808595;24865.627015594782;27644.447111057667;28367.43265134686;28419.57370639442;28493.857530712627;1124.7919134959895;1128.1031579894004;1142.3031950510183;1156.7281688803125;1265.936703164838;14477.986540942033;14511.346989385504;14753.704925901422;14758.188299643409;14871;304481;317119;319521.4023929865;320282.7971720253;321750;60185.69907150524;60974.780504390554;61089.69455152785;61177.69411153005;61178.38821611816;1262.5328628407365;1374.2785037855006;1465.0550394995382;1501.0393348257123;1510.9168995705343;28738.712612873605;28840.278993025342;29093.41813163767;29680.703192967794;29795.404091918474;48436.757816210695;48845;49463.50536494733;49515.50484495109;49732;440154;440971;442070;442169;442428.5757142516;26235.344116397242;26694.733052669224;38138.0465488365;39932.20135597214;40029.79985100056;43747;44519;44831.551684482736;45275.547244528454;45919.3112103312;35784;37134.44298335473;37982.43026354552;38079.04802379962;38308.42537361886;35418.8229058853;35460.46809297914;35947.82026089853;35978;37115.247136693855;30802.229944251572;30986.69013309928;32410.351792963538;36111.63888361083;36257.27485450223;28854.99007534726;30773.38453230878;30888.845555772976;31029.8448507756;31137.844310778302;23179.6523052151;23329.650055248847;23507.76492235124;23679.881600591885;23813.04747810068 01:20:08 INFO - PROCESS | 2001 | |2;jquery.html;397.8627373556124;398.3586425854372;399.67825900150376;400.33344481438405;402.7502948172132;13448.798268025987;19454.805451945474;20079.899600502013;20100;20689;15937.203139843019;17255.827441725578;19977;19995.300164494245;20707.585848283026;4797.808087676489;5908.734106965187;6111.266648002246;6112.419320164599;6326.841828954267;5810.418958104198;6058.3335833058545;6083.209182806229;6090.48230900374;6124.387561243884;6011.849703757419;6034.30605480371;6059.151718759377;6060.636361818283;6072.483838873701;5774.422557744213;6021.42796434338;6099.817005489843;6113.388661133896;6115.48018418435;5287.894242115136;5303;5306.230596563515;5306.73466326686;5316.521513063804;24792.3801904952;25220.621690674656;26224.164308498413;26323;26385.208443746717;2088;2221.3224966385246;2287.336672365012;2526.84838909666;2915.212892519008;11722.648320550397;12513;13402.932985335108;15209.847901520954;15214.923925380413;1736.6353065856185;1740.416960318295;1748.1521462090875;1805.0523475175507;1818.8999605021718;116062.41968790187;118820;120821.5219554141;124168.9999999991;124647;11543.480543375568;11577.247478913843;11641.301521908712;11675.474603642857;11837.76324473523;15089.622759431102;15199.544013679608;15201.771973420407;15214.619634509227;15228.923855380652;7330.816729581803;8233.135520770353;8579.14208579137;8726.432781869285;8755.299576033902;7098.254683258184;8521.744347669579;8566.614502347285;8679.305655547541;8794.824103517894;4577.542245775396;4651.953480465219;4654.930176047362;4679.438467383868;4716.764161791897;1660.3275673352312;1793.237873903612;1869.793982881034;1972.21111555379;1992.5989183034408;917.4586993673764;927.7448701607112;938.3759799733101;1013.3312014070679;1028.93311934724;16440.035888744795;19006.71489927652;20018.69971950422;20437;20446.284380046924;948.6347756113807;958.1759686669459;960.7406000379858;969.8642190093393;1022.3099407899638;8907.643694252287;10796.406197659204;10824.567017319376;10831.754348249895;10838.945805270923;579304;583753.0812345911;602792.986035067;604593;604865;99885;124515;126785;133516.66483335238;137001;969.6848524229654;975.1711045611315;985.4038306824411;988.456349008057;1014.7158795537409;12827.551035713705;15906.204689765696;17299.7405038922;17646.91176544109;18436.539086522946;47388;50218;50761.492385075675;50845;51939.740301298254;73567;73984.26015739773;74312;75779.62110189414;77526;7764.6894124234395;8007.879881801661;8009.239122283374;8202.958985205036;8555.101714320155;12002.519899204284;12298.81551776742;12696.301703406401;12716;12782.23306601607;10765.515551800032;11025.338479691245;11063.225574209728;11082.335059896432;11229.943850280697;10524.31591946521;10595.788084238426;10627.628033018807;10691.358518488916;10729.409882456228;11159.386233756897;11317;11356.375399353115;11393.943030285127;11527.942360288145;7988.760337189894;8073.15231900642;8163.224493673091;8381.161883811814;8443.902292702156;10563;11006.394648294421;11287.492062857027;11340.94329528347;11401.486933087865 01:20:08 INFO - PROCESS | 2001 | |3;mootools.html;1416.8441471438134;1622.4808061420347;1634.713925063114;1920.9807901920976;2043.090824583061;7035.36681698647;7443.851122977537;8565.528895910722;8574.785630359243;8581.785455363619;8299.83400331993;8324.83350332993;8494.405391622573;8502.319814414848;8520.616572254248;2144.453164443065;2378.286514045788;2406.506666133447;2463.187148241076;2466.6300054991716;2455.398427385293;2468.9259322220273;2469.71598266199;2475.121331927167;2475.5915273979863;2405.530921470314;2430.647556104364;2459.1270099114827;2465.395977985387;2469.5678256305164;2147.5168087180414;2361.6929799126005;2401.6157414813633;2408.927732168038;2434.9513009739885;2435.6468312094826;2461.1263001634343;2464.137551856854;2464.1745015419856;2473.1591258972035;8391.11893251206;8482.15178482153;8487.490750554987;8490.193431623986;8490.872636910452;5134.897302053975;5282.867928301823;5296.020236256305;5334.67991920486;5336.653117547347;3308.106811160997;3454.913627159316;3623.257232267405;3636.3636363636256;3638.6543278388513;1057.545255540125;1058.4654749351605;1061.4268295120703;1063.7181146996052;1079.4710591810035;11064.225504214708;11240.044596209333;11331.886681133248;11348.262362946465;11359.602413915472;4728.845359490797;4801.063792560487;4915.877103072452;4918.975405122951;4933.235348520985;9876.703698889045;10002;10014.899851001543;10025.649102281384;10033.247506437046;5247.921281180786;5395.136778115482;5396.62223644349;5407.459254074561;5418.45815418455;4193.203291374629;4376.212281789245;4525.705829121162;4551.52209018055;4847.5394837490385;3969.4244334571904;4028.3353246713964;4090.4886889138857;4120.17596480705;4123.113530590937;1302.4659889445472;1343.382044259632;1350.648831303868;1354.0995238166508;1360.836699596035;864.5720368417548;877.5085951866974;881.9196484306673;957.3490026781856;960.3229723045237;5633.183188437653;5800.738966746507;5894.528437724972;5909.349971503131;5962.2249107615735;447.4339959950665;459.56341475598316;465.8276437718066;466.30753331302986;472.15012976641907;3865.4781604483596;3929.017745563609;3937.9212415751526;4017.77902215381;4048.4534587830854;10003.149732272694;10347;10487.685369438928;10582.100521455608;10583.206259530565;10422.791544169075;10496.68509944703;10502.947485262524;10521.894781052091;10522.789544209072;7539.509931854412;7917.524948503108;7960.960195199103;8112;8112.107668156498;5868.061110222344;5872.324682661378;5975.193348898017;6015.218021657157;6047.213862197887;9386.5776040077;9682.75793105178;9752;9758.804823903623;9765.462899540593;9476.431414115175;9781.119699227103;9894.505274736379;10025.498725063864;10032.799344013225;6819.829504262433;7027.121609798775;7076.150861896605;7184.8922266165;7425.591592462466;8059;8076;8173.100958894398;8182.549959752271;8188.50868947865;7131.108611423572;7279.272072792678;7336.7798966031105;7415.555066696015;7427.665755041145;7134.32223938725;7148.28517148281;7195.820104497429;7218.458615603956;7235.493515453868;6749.662516874235;6928;6929.3070692930305;6940.722371105099;6953.33943275388;4405.9559404405545;4573.588377046081;4853.320535125014;4907.656464047483;5062.797488100435;4437.467503899553;4773.188557945227;4916.508349165055;4955.231939049453;5167.534921857051 01:20:08 INFO - PROCESS | 2001 | |4;prototype.html;315.38657311529073;316.8431626344958;324.6834336521893;325.8321964188443;329.37418904082256;4341.630961368283;4771.9761401192945;4794.640401969848;5136.614753893459;5190.948090519094;4511.887202819931;5107.872303192422;5150.69095854249;5160.961420239003;5168.3539557555305;3067.9386412271797;3877.595890547864;3948.2893079245723;4030.778307193103;4038.7980600969836;3308.073739352985;3377.172592714788;3729.832157552903;4011.7994100295014;4021.5375231848275;3965.385365268374;3965.5637879833193;3985.083430810915;3994.940075898864;4003.0392705750555;3620.71034317254;3800.467934489174;3886.7667939923695;3916.902077448058;3949.5584111799276;3472.0625431133453;3488.284901595167;3494.5806503219524;3503.8773642922374;3525.77391686609;4622.8905062785025;4945.431275403339;4963.528464795839;4973.62697797663;4992.575631071363;4169.311428871312;4291.77684359959;4307.741535507879;4382.627476664487;4451.332300154971;5027.773750181251;5359.222912677679;5384.542313903323;5395.028894798935;5420.915816836609;3839.558450778168;3847.4802453031175;3851.2105018471148;3852.2295540891655;3854.653081222675;4905.975470122627;5477.5070243677865;5661.716914154275;5683.175939488792;5710.400407957146;3804.4048374286585;3880.223955208913;3881.6506514413836;3897.9610203898164;3905.746126501825;3369.5114208440127;3478.652134786552;3587.6053634100226;3795.791231482295;3960.7821569813937;4502.549745025472;4525.321201819754;4541.954580454153;4547.15877562652;4562.58936695699;4541.72749635023;5147.922781158286;5211.869703257449;5367.624266301322;5541.722913854291;1221.6701490597666;1274.5093139141497;1311.4557458654551;1313.8700717383042;1417.9861399099486;861.8752527950959;885.9335549833788;915.3821170709745;926.1063074133493;949.8717673114041;5009.949900500948;5133.614978876599;5139.280500729901;5445.373782015119;5461.01701693691;5083.61872859537;5463.104554586076;5574.637648552831;5616.354119276336;5624.409437009137;4351.738895666207;4406.911861762746;5080.441151473335;5088.974555127201;5108.055009823194;2597.9610305845426;3200.535922291255;3220.243242837931;3222.935541289208;3247.918802029968;5382.519807053013;6259.311475737665;6378.639903235832;6385.2656944451055;6421.165248517663;5856.882862342814;6295.496360291166;6324.810255692337;6354.459870910932;6356.188486281388;5853.326867410302;6403.199600049994;6404.455621272151;6408.775692850728;6423.74305027803;5679.37526872052;5843.883122337615;6116.35778243278;6193.194884664965;6204.906926396017;5096.668716533413;6068.302145253176;6092.933736596166;6096.420840020191;6125.356837531995;5289.444608316071;6265.686715664289;6393.456556192589;6407.583507072025;6416.486681065597;3999.8600048998146;4038.51537815464;4049.5140583130215;4061.4923134608175;4066.9389959150044;6115.908261375994;6127.540434467522;6141.785037523665;6159.306190797566;6211;5108.846734597968;5484.561235101262;5932.4957378621575;5962.880742385215;5976.282846058501;5425.538829199562;5442.455754424526;5469.753861076181;5494.36814766307;5522.337319521683;4325.24308246062;4814.194676996127;5112.412072611549;5179.896402072013;5402.243685883901;4102.897427564335;4649.139909116824;4945.016529998742;5163.535281824654;5397.244385786072;4800.951990480051;5282.339707536558;5407.78368865241;5448.782048718007;5449.782008719607 01:20:08 INFO - PROCESS | 2001 | |5;yui.html;563.9718014099295;573.7676241122347;606.0666473948103;606.7178761875729;614.7233744814831;14612.4885629003;14680.412783488648;15056.397744090236;15058.322375493102;15420.61448463789;14199.574012779607;14264.500742474016;14312;14336.139831610111;14354.641133971656;747.5141158247155;768.7885831396355;914.8307563100848;927.9860802087974;936.9203617692505;941.7174847545743;947.9951251673249;952.3761935931941;953.1374106433689;959.3716115944068;1005.4771518810251;1007.4005966449951;1010.8837483689359;1011.3123076308108;1012.8227560176977;778.5562229529171;962.3071388600197;995.3778888194878;999.6701088640731;1000.3547711725932;746.1642959884964;747.6897087708594;748.0985412577885;748.913874904382;750.5459197185679;14757.704845903021;14856.405743770236;14879.851201487954;14902.627434314121;14921.552353429415;12390.56633017849;12486.81269780954;12655.810162847565;12657.936710316482;12700.618981430573;9093.363464557484;9110.954445227731;9151.359404841663;9190;9356.298277629205;3463.5843698756057;3474.513568100468;3476.6001909780193;3520.2783429396914;3737.2808508086314;78288.60855695685;78922;79091.6045419775;79876.60061699654;80039.799403009;9226.53867306632;9443.527823608792;9448.291378146667;9716.75708107303;9758.463284519277;21729.130834766747;21765.891170544044;21794.782052179275;21802.672959905613;22099.447513812283;7294.489385742947;7379.520331178456;7423.777286681408;7465.992091067745;7615.390768738598;3558.733095017884;4004.839806407769;4083.0813067060267;4091.774952377648;4106.507219133723;3510.1575621851084;3572.7499075065016;3576.481410195559;3578.7494875359;3586.964130358663;617.2222999021266;622.707327556048;633.341325021972;652.3476523476523;653.2422390027546;539.7948779463857;549.1844610753028;549.5081901697957;586.4135864135864;615.4706952021259;8051.436399451982;8076.768498717369;8228.711995080144;8302;8343.165683431609;574.2878830250543;582.7785441532191;606.5178183344252;607.1963647331638;613.0742578706097;3669.541307336583;3682.779033258013;3861.613838616116;3883.902902427462;3904.3362628353248;82988;87105.56447217724;87169;90774;90780;59910.70044649749;76383;76901.23098769052;77996.61001694955;80301.59849200833;66748.66625666937;68111;68268.99999999901;68403;68638;6888.621125838127;7287.307705767944;7696.7306144284685;8472.389000443489;8498.575071246289;36001.81999089988;42779.57220427756;43441.565584345015;44685.776571116934;46025;58244.12633810411;67766.66116669386;67985.66007169933;68219;70792.29207707857;10883.510242038968;11035.668929932115;11218.607348742755;11298.887011129784;11324.660260192208;11836.230645008047;11904.880951190376;11914.76170476603;12289.385530723606;12618.49526018949;11315.321080735182;11469.31184128955;11720.413979301171;11727.530898763955;11800.881991179978;11054.11567074616;11217.383043932661;11283.32300061966;11301.886981130083;11615.709607259887;11202.775944480902;11228.93325134111;11251.887481125084;11257;11261.493232804707;9715.951420242853;9804.117629413387;9891.901080989386;9938.503074846085;10037;9458.148766611039;9686.643572550633;9710.126088651772;9749.463779492196;9934.751631209278 01:20:08 INFO - PROCESS | 2001 | __end_tp_report 01:20:08 INFO - PROCESS | 2001 | __start_cc_report 01:20:08 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,1133 01:20:08 INFO - PROCESS | 2001 | __end_cc_report 01:20:08 INFO - PROCESS | 2001 | __startTimestamp1461918008517__endTimestamp 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | ------- Summary: start ------- 01:20:08 INFO - PROCESS | 2001 | Number of tests: 6 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:5625.78 Median:5807.94 stddev:618.64 (10.7%) stddev-sans-first:588.86 01:20:08 INFO - PROCESS | 2001 | Values: 3134.6 3373.3 3387.0 3411.1 3447.7 5547.0 5593.3 5629.0 5646.7 5660.2 5584.2 5606.8 5611.6 5678.7 5685.9 5075.5 5113.3 5126.1 5145.8 5269.7 5232.3 5268.3 5275.4 5283.0 5331.5 5102.9 5168.2 5188.5 5195.2 5223.6 4328.4 5105.6 5158.5 5169.4 5174.9 5114.5 5123.5 5148.0 5158.7 5166.9 5454.2 5554.8 5562.2 5563.6 5579.6 4999.7 6080.0 6089.7 6091.0 6123.0 6104.6 6105.5 6152.1 6170.4 6170.7 5586.6 5659.6 5663.7 5706.4 5734.5 6170.4 6236.1 6256.4 6265.7 6272.9 6006.0 6031.8 6040.0 6044.0 6044.8 6040.6 6113.3 6134.4 6180.4 6187.6 6060.9 6100.7 6101.1 6110.6 6121.8 6123.8 6137.5 6140.7 6146.8 6147.4 4783.4 4810.8 4843.1 4848.5 4907.7 4290.4 4309.5 4324.8 4344.9 4346.4 5426.0 5441.5 5441.7 5447.2 5455.3 5854.8 5887.1 5933.6 5940.6 5957.1 5562.3 5616.1 5651.5 5656.3 5671.3 5323.7 5331.2 5333.8 5341.3 5365.5 5973.9 6203.4 6229.0 6246.3 6253.5 6077.6 6101.8 6141.4 6155.1 6201.4 6204.5 6212.4 6227.3 6229.2 6254.9 6083.7 6115.3 6121.4 6128.4 6134.9 5385.6 5840.8 6044.7 6109.6 6125.2 5861.5 5872.7 5877.1 5904.6 5905.4 5809.4 5846.5 5856.4 5867.1 5867.8 5728.5 5752.9 5770.0 5783.4 5807.9 5993.9 6016.8 6037.5 6058.2 6087.0 5747.3 5860.1 5878.1 5899.8 5902.6 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:54979.85 Median:36184.46 stddev:109291.35 (302.0%) stddev-sans-first:109521.48 01:20:08 INFO - PROCESS | 2001 | Values: 531.1 533.8 583.9 590.4 621.6 30851.0 31310.4 38858.1 39552.0 39648.0 44425.8 45056.8 45087.3 45100.0 45235.0 9593.8 9841.2 9846.9 9849.8 9878.9 9675.3 9854.9 9856.8 9857.9 9891.8 9850.3 9913.9 9924.5 9945.7 9947.3 9819.7 9883.6 9884.3 9892.6 9900.5 9636.0 9731.2 9768.6 9783.2 9784.5 41230.0 41521.0 41540.6 41582.6 41673.8 3218.6 3235.8 3245.2 3435.1 3666.1 25145.0 25484.6 25520.5 26100.6 26129.7 2746.3 2755.4 2786.6 2848.3 2868.7 460443.0 461904.0 462355.0 462768.7 463683.7 32802.8 58781.1 60095.0 60271.7 60292.7 34746.0 34780.3 34851.8 34905.3 35084.3 15385.8 15527.9 15656.5 15682.7 15702.9 13036.0 13124.6 13135.1 13145.1 13183.9 8204.7 8209.4 8234.6 8287.5 8324.2 3356.2 3388.7 3406.1 3417.8 3418.8 966.6 983.8 1036.3 1056.7 1119.4 24865.6 27644.4 28367.4 28419.6 28493.9 1124.8 1128.1 1142.3 1156.7 1265.9 14478.0 14511.3 14753.7 14758.2 14871.0 304481.0 317119.0 319521.4 320282.8 321750.0 60185.7 60974.8 61089.7 61177.7 61178.4 1262.5 1374.3 1465.1 1501.0 1510.9 28738.7 28840.3 29093.4 29680.7 29795.4 48436.8 48845.0 49463.5 49515.5 49732.0 440154.0 440971.0 442070.0 442169.0 442428.6 26235.3 26694.7 38138.0 39932.2 40029.8 43747.0 44519.0 44831.6 45275.5 45919.3 35784.0 37134.4 37982.4 38079.0 38308.4 35418.8 35460.5 35947.8 35978.0 37115.2 30802.2 30986.7 32410.4 36111.6 36257.3 28855.0 30773.4 30888.8 31029.8 31137.8 23179.7 23329.7 23507.8 23679.9 23813.0 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:34676.79 Median:25006.50 stddev:99322.60 (397.2%) stddev-sans-first:99567.88 01:20:08 INFO - PROCESS | 2001 | Values: 397.9 398.4 399.7 400.3 402.8 13448.8 19454.8 20079.9 20100.0 20689.0 15937.2 17255.8 19977.0 19995.3 20707.6 4797.8 5908.7 6111.3 6112.4 6326.8 5810.4 6058.3 6083.2 6090.5 6124.4 6011.8 6034.3 6059.2 6060.6 6072.5 5774.4 6021.4 6099.8 6113.4 6115.5 5287.9 5303.0 5306.2 5306.7 5316.5 24792.4 25220.6 26224.2 26323.0 26385.2 2088.0 2221.3 2287.3 2526.8 2915.2 11722.6 12513.0 13402.9 15209.8 15214.9 1736.6 1740.4 1748.2 1805.1 1818.9 116062.4 118820.0 120821.5 124169.0 124647.0 11543.5 11577.2 11641.3 11675.5 11837.8 15089.6 15199.5 15201.8 15214.6 15228.9 7330.8 8233.1 8579.1 8726.4 8755.3 7098.3 8521.7 8566.6 8679.3 8794.8 4577.5 4652.0 4654.9 4679.4 4716.8 1660.3 1793.2 1869.8 1972.2 1992.6 917.5 927.7 938.4 1013.3 1028.9 16440.0 19006.7 20018.7 20437.0 20446.3 948.6 958.2 960.7 969.9 1022.3 8907.6 10796.4 10824.6 10831.8 10838.9 579304.0 583753.1 602793.0 604593.0 604865.0 99885.0 124515.0 126785.0 133516.7 137001.0 969.7 975.2 985.4 988.5 1014.7 12827.6 15906.2 17299.7 17646.9 18436.5 47388.0 50218.0 50761.5 50845.0 51939.7 73567.0 73984.3 74312.0 75779.6 77526.0 7764.7 8007.9 8009.2 8203.0 8555.1 12002.5 12298.8 12696.3 12716.0 12782.2 10765.5 11025.3 11063.2 11082.3 11229.9 10524.3 10595.8 10627.6 10691.4 10729.4 11159.4 11317.0 11356.4 11393.9 11527.9 7988.8 8073.2 8163.2 8381.2 8443.9 10563.0 11006.4 11287.5 11340.9 11401.5 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:5604.24 Median:4824.30 stddev:3094.37 (64.1%) stddev-sans-first:3087.04 01:20:08 INFO - PROCESS | 2001 | Values: 1416.8 1622.5 1634.7 1921.0 2043.1 7035.4 7443.9 8565.5 8574.8 8581.8 8299.8 8324.8 8494.4 8502.3 8520.6 2144.5 2378.3 2406.5 2463.2 2466.6 2455.4 2468.9 2469.7 2475.1 2475.6 2405.5 2430.6 2459.1 2465.4 2469.6 2147.5 2361.7 2401.6 2408.9 2435.0 2435.6 2461.1 2464.1 2464.2 2473.2 8391.1 8482.2 8487.5 8490.2 8490.9 5134.9 5282.9 5296.0 5334.7 5336.7 3308.1 3454.9 3623.3 3636.4 3638.7 1057.5 1058.5 1061.4 1063.7 1079.5 11064.2 11240.0 11331.9 11348.3 11359.6 4728.8 4801.1 4915.9 4919.0 4933.2 9876.7 10002.0 10014.9 10025.6 10033.2 5247.9 5395.1 5396.6 5407.5 5418.5 4193.2 4376.2 4525.7 4551.5 4847.5 3969.4 4028.3 4090.5 4120.2 4123.1 1302.5 1343.4 1350.6 1354.1 1360.8 864.6 877.5 881.9 957.3 960.3 5633.2 5800.7 5894.5 5909.3 5962.2 447.4 459.6 465.8 466.3 472.2 3865.5 3929.0 3937.9 4017.8 4048.5 10003.1 10347.0 10487.7 10582.1 10583.2 10422.8 10496.7 10502.9 10521.9 10522.8 7539.5 7917.5 7961.0 8112.0 8112.1 5868.1 5872.3 5975.2 6015.2 6047.2 9386.6 9682.8 9752.0 9758.8 9765.5 9476.4 9781.1 9894.5 10025.5 10032.8 6819.8 7027.1 7076.2 7184.9 7425.6 8059.0 8076.0 8173.1 8182.5 8188.5 7131.1 7279.3 7336.8 7415.6 7427.7 7134.3 7148.3 7195.8 7218.5 7235.5 6749.7 6928.0 6929.3 6940.7 6953.3 4406.0 4573.6 4853.3 4907.7 5062.8 4437.5 4773.2 4916.5 4955.2 5167.5 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:4558.80 Median:5054.11 stddev:1451.53 (28.7%) stddev-sans-first:1420.22 01:20:08 INFO - PROCESS | 2001 | Values: 315.4 316.8 324.7 325.8 329.4 4341.6 4772.0 4794.6 5136.6 5190.9 4511.9 5107.9 5150.7 5161.0 5168.4 3067.9 3877.6 3948.3 4030.8 4038.8 3308.1 3377.2 3729.8 4011.8 4021.5 3965.4 3965.6 3985.1 3994.9 4003.0 3620.7 3800.5 3886.8 3916.9 3949.6 3472.1 3488.3 3494.6 3503.9 3525.8 4622.9 4945.4 4963.5 4973.6 4992.6 4169.3 4291.8 4307.7 4382.6 4451.3 5027.8 5359.2 5384.5 5395.0 5420.9 3839.6 3847.5 3851.2 3852.2 3854.7 4906.0 5477.5 5661.7 5683.2 5710.4 3804.4 3880.2 3881.7 3898.0 3905.7 3369.5 3478.7 3587.6 3795.8 3960.8 4502.5 4525.3 4542.0 4547.2 4562.6 4541.7 5147.9 5211.9 5367.6 5541.7 1221.7 1274.5 1311.5 1313.9 1418.0 861.9 885.9 915.4 926.1 949.9 5009.9 5133.6 5139.3 5445.4 5461.0 5083.6 5463.1 5574.6 5616.4 5624.4 4351.7 4406.9 5080.4 5089.0 5108.1 2598.0 3200.5 3220.2 3222.9 3247.9 5382.5 6259.3 6378.6 6385.3 6421.2 5856.9 6295.5 6324.8 6354.5 6356.2 5853.3 6403.2 6404.5 6408.8 6423.7 5679.4 5843.9 6116.4 6193.2 6204.9 5096.7 6068.3 6092.9 6096.4 6125.4 5289.4 6265.7 6393.5 6407.6 6416.5 3999.9 4038.5 4049.5 4061.5 4066.9 6115.9 6127.5 6141.8 6159.3 6211.0 5108.8 5484.6 5932.5 5962.9 5976.3 5425.5 5442.5 5469.8 5494.4 5522.3 4325.2 4814.2 5112.4 5179.9 5402.2 4102.9 4649.1 4945.0 5163.5 5397.2 4801.0 5282.3 5407.8 5448.8 5449.8 01:20:08 INFO - PROCESS | 2001 | 01:20:08 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:17720.59 Median:30248.56 stddev:24633.95 (81.4%) stddev-sans-first:24669.37 01:20:08 INFO - PROCESS | 2001 | Values: 564.0 573.8 606.1 606.7 614.7 14612.5 14680.4 15056.4 15058.3 15420.6 14199.6 14264.5 14312.0 14336.1 14354.6 747.5 768.8 914.8 928.0 936.9 941.7 948.0 952.4 953.1 959.4 1005.5 1007.4 1010.9 1011.3 1012.8 778.6 962.3 995.4 999.7 1000.4 746.2 747.7 748.1 748.9 750.5 14757.7 14856.4 14879.9 14902.6 14921.6 12390.6 12486.8 12655.8 12657.9 12700.6 9093.4 9111.0 9151.4 9190.0 9356.3 3463.6 3474.5 3476.6 3520.3 3737.3 78288.6 78922.0 79091.6 79876.6 80039.8 9226.5 9443.5 9448.3 9716.8 9758.5 21729.1 21765.9 21794.8 21802.7 22099.4 7294.5 7379.5 7423.8 7466.0 7615.4 3558.7 4004.8 4083.1 4091.8 4106.5 3510.2 3572.7 3576.5 3578.7 3587.0 617.2 622.7 633.3 652.3 653.2 539.8 549.2 549.5 586.4 615.5 8051.4 8076.8 8228.7 8302.0 8343.2 574.3 582.8 606.5 607.2 613.1 3669.5 3682.8 3861.6 3883.9 3904.3 82988.0 87105.6 87169.0 90774.0 90780.0 59910.7 76383.0 76901.2 77996.6 80301.6 66748.7 68111.0 68269.0 68403.0 68638.0 6888.6 7287.3 7696.7 8472.4 8498.6 36001.8 42779.6 43441.6 44685.8 46025.0 58244.1 67766.7 67985.7 68219.0 70792.3 10883.5 11035.7 11218.6 11298.9 11324.7 11836.2 11904.9 11914.8 12289.4 12618.5 11315.3 11469.3 11720.4 11727.5 11800.9 11054.1 11217.4 11283.3 11301.9 11615.7 11202.8 11228.9 11251.9 11257.0 11261.5 9716.0 9804.1 9891.9 9938.5 10037.0 9458.1 9686.6 9710.1 9749.5 9934.8 01:20:08 INFO - PROCESS | 2001 | -------- Summary: end -------- 01:20:08 INFO - PROCESS | 2001 | 01:20:09 INFO - TEST-INFO | 2001: exit 0 01:20:09 INFO - TEST-OK | dromaeo_css | took 1115215ms 01:20:09 INFO - TEST-START | kraken 01:20:09 INFO - operating with platform_type : mac_ 01:20:09 INFO - Initialising browser for kraken test... 01:20:09 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpgZDGWG/profile http://localhost:51349/getInfo.html) 01:20:11 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 01:20:11 INFO - PROCESS | 2004 | colorDepth:24 01:20:11 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 01:20:11 INFO - PROCESS | 2004 | __metrics 01:20:11 INFO - PROCESS | 2004 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:20:11 ERROR - PROCESS | 2004 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:20:12 INFO - TEST-INFO | 2004: exit 0 01:20:12 INFO - Browser initialized. 01:20:12 INFO - Running cycle 1/1 for kraken test... 01:20:12 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpgZDGWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:24 INFO - PROCESS | 2006 | RSS: Main: 239484928 01:20:24 INFO - PROCESS | 2006 | 01:20:26 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-beat-detection) 01:20:27 INFO - PROCESS | 2006 | RSS: Main: 287477760 01:20:27 INFO - PROCESS | 2006 | 01:20:30 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-dft) 01:20:31 INFO - PROCESS | 2006 | RSS: Main: 297111552 01:20:31 INFO - PROCESS | 2006 | 01:20:34 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-fft) 01:20:35 INFO - PROCESS | 2006 | RSS: Main: 382971904 01:20:35 INFO - PROCESS | 2006 | 01:20:37 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51349/tests/kraken/driver.html?testName=audio-oscillator) 01:20:37 INFO - PROCESS | 2006 | RSS: Main: 283738112 01:20:37 INFO - PROCESS | 2006 | 01:20:39 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:20:40 INFO - PROCESS | 2006 | RSS: Main: 287481856 01:20:40 INFO - PROCESS | 2006 | 01:20:43 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-darkroom) 01:20:43 INFO - PROCESS | 2006 | RSS: Main: 326201344 01:20:43 INFO - PROCESS | 2006 | 01:20:46 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51349/tests/kraken/driver.html?testName=imaging-desaturate) 01:20:47 INFO - PROCESS | 2006 | RSS: Main: 326074368 01:20:47 INFO - PROCESS | 2006 | 01:20:49 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51349/tests/kraken/driver.html?testName=json-parse-financial) 01:20:50 INFO - PROCESS | 2006 | RSS: Main: 325251072 01:20:50 INFO - PROCESS | 2006 | 01:20:52 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:20:52 INFO - PROCESS | 2006 | RSS: Main: 314884096 01:20:52 INFO - PROCESS | 2006 | 01:20:54 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:20:55 INFO - PROCESS | 2006 | RSS: Main: 322322432 01:20:55 INFO - PROCESS | 2006 | 01:20:57 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:20:58 INFO - PROCESS | 2006 | RSS: Main: 324083712 01:20:58 INFO - PROCESS | 2006 | 01:21:01 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:21:01 INFO - PROCESS | 2006 | RSS: Main: 321064960 01:21:01 INFO - PROCESS | 2006 | 01:21:04 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:21:05 INFO - PROCESS | 2006 | RSS: Main: 321773568 01:21:05 INFO - PROCESS | 2006 | 01:21:06 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:51349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51349/tests/kraken/driver.html?testName=ai-astar) 01:21:07 INFO - PROCESS | 2006 | RSS: Main: 386248704 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | __start_tp_report 01:21:07 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 01:21:07 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 01:21:07 INFO - PROCESS | 2006 | |i|pagename|runs| 01:21:07 INFO - PROCESS | 2006 | |0;ai-astar;113;112;107;113;113;112;118;114;106;111 01:21:07 INFO - PROCESS | 2006 | |1;audio-beat-detection;157;135;143;171;121;145;129;149;201;141 01:21:07 INFO - PROCESS | 2006 | |2;audio-dft;186;189;187;186;185;188;185;195;185;183 01:21:07 INFO - PROCESS | 2006 | |3;audio-fft;76;71;92;92;56;59;57;83;97;56 01:21:07 INFO - PROCESS | 2006 | |4;audio-oscillator;93;94;138;78;81;81;121;74;78;127 01:21:07 INFO - PROCESS | 2006 | |5;imaging-gaussian-blur;87;85;88;84;89;84;84;85;87;84 01:21:07 INFO - PROCESS | 2006 | |6;imaging-darkroom;94;94;95;94;94;94;94;94;95;93 01:21:07 INFO - PROCESS | 2006 | |7;imaging-desaturate;87;84;85;86;85;86;86;87;85;85 01:21:07 INFO - PROCESS | 2006 | |8;json-parse-financial;60;61;61;61;57;58;58;75;59;57 01:21:07 INFO - PROCESS | 2006 | |9;json-stringify-tinderbox;66;73;78;74;69;68;66;68;67;70 01:21:07 INFO - PROCESS | 2006 | |10;stanford-crypto-aes;84;83;82;82;83;82;82;82;83;83 01:21:07 INFO - PROCESS | 2006 | |11;stanford-crypto-ccm;140;137;137;134;133;139;152;149;190;136 01:21:07 INFO - PROCESS | 2006 | |12;stanford-crypto-pbkdf2;170;170;169;171;171;169;169;168;168;168 01:21:07 INFO - PROCESS | 2006 | |13;stanford-crypto-sha256-iterative;68;68;70;68;68;69;71;70;68;70 01:21:07 INFO - PROCESS | 2006 | __end_tp_report 01:21:07 INFO - PROCESS | 2006 | __start_cc_report 01:21:07 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,2009 01:21:07 INFO - PROCESS | 2006 | __end_cc_report 01:21:07 INFO - PROCESS | 2006 | __startTimestamp1461918067202__endTimestamp 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | ------- Summary: start ------- 01:21:07 INFO - PROCESS | 2006 | Number of tests: 14 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.41 (3.0%) stddev-sans-first:3.60 01:21:07 INFO - PROCESS | 2006 | Values: 113.0 112.0 107.0 113.0 113.0 112.0 118.0 114.0 106.0 111.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:147.00 stddev:22.97 (15.6%) stddev-sans-first:24.19 01:21:07 INFO - PROCESS | 2006 | Values: 157.0 135.0 143.0 171.0 121.0 145.0 129.0 149.0 201.0 141.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#2] audio-dft Cycles:10 Average:186.90 Median:186.50 stddev:3.31 (1.8%) stddev-sans-first:3.50 01:21:07 INFO - PROCESS | 2006 | Values: 186.0 189.0 187.0 186.0 185.0 188.0 185.0 195.0 185.0 183.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#3] audio-fft Cycles:10 Average:73.90 Median:79.50 stddev:16.44 (20.7%) stddev-sans-first:17.42 01:21:07 INFO - PROCESS | 2006 | Values: 76.0 71.0 92.0 92.0 56.0 59.0 57.0 83.0 97.0 56.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.50 stddev:23.43 (29.5%) stddev-sans-first:24.82 01:21:07 INFO - PROCESS | 2006 | Values: 93.0 94.0 138.0 78.0 81.0 81.0 121.0 74.0 78.0 127.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:86.00 stddev:1.89 (2.2%) stddev-sans-first:1.94 01:21:07 INFO - PROCESS | 2006 | Values: 87.0 85.0 88.0 84.0 89.0 84.0 84.0 85.0 87.0 84.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:21:07 INFO - PROCESS | 2006 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 01:21:07 INFO - PROCESS | 2006 | Values: 87.0 84.0 85.0 86.0 85.0 86.0 86.0 87.0 85.0 85.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.50 stddev:5.27 (8.7%) stddev-sans-first:5.59 01:21:07 INFO - PROCESS | 2006 | Values: 60.0 61.0 61.0 61.0 57.0 58.0 58.0 75.0 59.0 57.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:3.93 (5.7%) stddev-sans-first:3.91 01:21:07 INFO - PROCESS | 2006 | Values: 66.0 73.0 78.0 74.0 69.0 68.0 66.0 68.0 67.0 70.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 01:21:07 INFO - PROCESS | 2006 | Values: 84.0 83.0 82.0 82.0 83.0 82.0 82.0 82.0 83.0 83.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:139.50 stddev:17.08 (12.2%) stddev-sans-first:18.03 01:21:07 INFO - PROCESS | 2006 | Values: 140.0 137.0 137.0 134.0 133.0 139.0 152.0 149.0 190.0 136.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:1.16 (0.7%) stddev-sans-first:1.20 01:21:07 INFO - PROCESS | 2006 | Values: 170.0 170.0 169.0 171.0 171.0 169.0 169.0 168.0 168.0 168.0 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - PROCESS | 2006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 01:21:07 INFO - PROCESS | 2006 | Values: 68.0 68.0 70.0 68.0 68.0 69.0 71.0 70.0 68.0 70.0 01:21:07 INFO - PROCESS | 2006 | -------- Summary: end -------- 01:21:07 INFO - PROCESS | 2006 | 01:21:07 INFO - TEST-INFO | 2006: exit 0 01:21:08 INFO - TEST-OK | kraken | took 58926ms 01:21:08 INFO - SUITE-END | took 1174s 01:21:08 INFO - Completed test suite (00:19:34) 01:21:08 INFO - javascript benchmark 01:21:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.639516455608, 3373.342198271338, 3387.0177648481936, 3411.0960595442198, 3447.7241820654335, 5546.972265138679, 5593.300837395325, 5629.0, 5646.661200327978, 5660.207570940067, 5584.162375643646, 5606.803761868336, 5611.579131565129, 5678.744456499458, 5685.943140568593, 5075.467075957026, 5113.335266415361, 5126.077306084903, 5145.768440420171, 5269.65747226431, 5232.3459567554055, 5268.31511903452, 5275.393329767087, 5282.973585132069, 5331.466853314657, 5102.948970510284, 5168.173092305251, 5188.45521220274, 5195.168772996302, 5223.6343455958095, 4328.4156638853665, 5105.566026887719, 5158.509941555546, 5169.353830771153, 5174.896502069938, 5114.539691427753, 5123.487651234884, 5147.974260128675, 5158.74206289684, 5166.948330516684, 5454.181872719124, 5554.833354999357, 5562.249096371978, 5563.554915606742, 5579.581531385163, 4999.650024498286, 6079.961675881735, 6089.665068421235, 6091.006450648836, 6122.977604208165, 6104.572679912408, 6105.511559075263, 6152.077188421727, 6170.352113028157, 6170.691465426711, 5586.608937374426, 5659.603827732019, 5663.716814159276, 5706.400827913092, 5734.483896449298, 6170.444659980623, 6236.095766113979, 6256.436920677161, 6265.686715664198, 6272.874542509125, 6005.969970150121, 6031.7587296507645, 6040.033594624839, 6044.0, 6044.758209671564, 6040.607360521552, 6113.32753397126, 6134.38656134383, 6180.4437600615265, 6187.628742275478, 6060.939390606038, 6100.702285529923, 6101.095933926299, 6110.558759196641, 6121.755129794758, 6123.817328466031, 6137.478314343331, 6140.662263575547, 6146.846328841725, 6147.44672979425, 4783.425988881357, 4810.831620893252, 4843.104025755247, 4848.466668666444, 4907.730074845917, 4290.399344091829, 4309.461317335333, 4324.762138082436, 4344.913101737948, 4346.391505189276, 5426.0, 5441.537469315073, 5441.727913604304, 5447.1829225616475, 5455.263539422207, 5854.795082172103, 5887.058070708752, 5933.614315069507, 5940.61386009908, 5957.076653118774, 5562.332520097533, 5616.129499927518, 5651.491365777099, 5656.321241451053, 5671.291088613923, 5323.680579165262, 5331.173668081454, 5333.7866485340155, 5341.305630268041, 5365.490278423544, 5973.910391344047, 6203.4416902479, 6229.0, 6246.312905580292, 6253.530985176039, 6077.604955677867, 6101.816945491642, 6141.424638644238, 6155.076738489083, 6201.410865967726, 6204.534659900616, 6212.409821067172, 6227.314995350417, 6229.190205273286, 6254.906176407267, 6083.726232319467, 6115.296740874856, 6121.418465245794, 6128.387161283836, 6134.938650613437, 5385.6230063895155, 5840.795572155124, 6044.7279872406725, 6109.586862300561, 6125.203723515914, 5861.501772349398, 5872.735726892215, 5877.147813566923, 5904.645721256738, 5905.350411454822, 5809.390014048633, 5846.503047241032, 5856.385079566584, 5867.119932010062, 5867.765289388377, 5728.484436400744, 5752.884942301214, 5770.0, 5783.3638299787835, 5807.94192058074, 5993.850153746017, 6016.789412370546, 6037.45662890342, 6058.242719660043, 6086.969565152146, 5747.3103227612955, 5860.120981852756, 5878.118282257696, 5899.823005309848, 5902.61632993854], "value": 5587.06398431844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.1050879268433, 533.8318429694647, 583.9445252700993, 590.3948452835846, 621.5711159300082, 30851.0, 31310.373792524137, 38858.11418858113, 39552.0, 39648.0, 44425.7778711106, 45056.774716126376, 45087.32369014459, 45100.0, 45235.0, 9593.808123837536, 9841.21270298378, 9846.852297215548, 9849.803003939916, 9878.851817222747, 9675.322727409084, 9854.90145098547, 9856.802863942718, 9857.852132218022, 9891.752706182331, 9850.261230407712, 9913.900860991405, 9924.45415502147, 9945.701628951107, 9947.253955953296, 9819.705408837746, 9883.604655813831, 9884.258680598983, 9892.604295828158, 9900.50497475127, 9635.98822123681, 9731.172850307732, 9768.560414781352, 9783.168430683401, 9784.510774461249, 41230.0, 41521.0, 41540.58459415428, 41582.58417415847, 41673.79163104165, 3218.5976752905885, 3235.7573182011442, 3245.237369218232, 3435.1068722132177, 3666.138457462494, 25145.0, 25484.617730734055, 25520.48959020828, 26100.60849087265, 26129.73870261311, 2746.32714984828, 2755.3800394911186, 2786.5680819473014, 2848.330642299058, 2868.698786627395, 460443.0, 461904.0, 462355.0, 462768.68615656707, 463683.6815815933, 32802.83598581992, 58781.118283225784, 60095.0, 60271.69864150739, 60292.698536507036, 34746.0, 34780.30439391198, 34851.825740871136, 34905.30189396249, 35084.29831403358, 15385.769213461806, 15527.922360388351, 15656.530304090895, 15682.68634627301, 15702.921485392728, 13036.0, 13124.606261812161, 13135.080544361994, 13145.145565538209, 13183.945284377418, 8204.671813127527, 8209.38429617781, 8234.629441675139, 8287.461315014505, 8324.209200125979, 3356.2280675444295, 3388.711959483422, 3406.114410253352, 3417.829108544563, 3418.8461519231696, 966.6181858165985, 983.829243200589, 1036.290141253229, 1056.7410984308895, 1119.35467808595, 24865.627015594782, 27644.447111057667, 28367.43265134686, 28419.57370639442, 28493.857530712627, 1124.7919134959895, 1128.1031579894004, 1142.3031950510183, 1156.7281688803125, 1265.936703164838, 14477.986540942033, 14511.346989385504, 14753.704925901422, 14758.188299643409, 14871.0, 304481.0, 317119.0, 319521.4023929865, 320282.7971720253, 321750.0, 60185.69907150524, 60974.780504390554, 61089.69455152785, 61177.69411153005, 61178.38821611816, 1262.5328628407365, 1374.2785037855006, 1465.0550394995382, 1501.0393348257123, 1510.9168995705343, 28738.712612873605, 28840.278993025342, 29093.41813163767, 29680.703192967794, 29795.404091918474, 48436.757816210695, 48845.0, 49463.50536494733, 49515.50484495109, 49732.0, 440154.0, 440971.0, 442070.0, 442169.0, 442428.5757142516, 26235.344116397242, 26694.733052669224, 38138.0465488365, 39932.20135597214, 40029.79985100056, 43747.0, 44519.0, 44831.551684482736, 45275.547244528454, 45919.3112103312, 35784.0, 37134.44298335473, 37982.43026354552, 38079.04802379962, 38308.42537361886, 35418.8229058853, 35460.46809297914, 35947.82026089853, 35978.0, 37115.247136693855, 30802.229944251572, 30986.69013309928, 32410.351792963538, 36111.63888361083, 36257.27485450223, 28854.99007534726, 30773.38453230878, 30888.845555772976, 31029.8448507756, 31137.844310778302, 23179.6523052151, 23329.650055248847, 23507.76492235124, 23679.881600591885, 23813.04747810068], "value": 18078.619182357874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.8627373556124, 398.3586425854372, 399.67825900150376, 400.33344481438405, 402.7502948172132, 13448.798268025987, 19454.805451945474, 20079.899600502013, 20100.0, 20689.0, 15937.203139843019, 17255.827441725578, 19977.0, 19995.300164494245, 20707.585848283026, 4797.808087676489, 5908.734106965187, 6111.266648002246, 6112.419320164599, 6326.841828954267, 5810.418958104198, 6058.3335833058545, 6083.209182806229, 6090.48230900374, 6124.387561243884, 6011.849703757419, 6034.30605480371, 6059.151718759377, 6060.636361818283, 6072.483838873701, 5774.422557744213, 6021.42796434338, 6099.817005489843, 6113.388661133896, 6115.48018418435, 5287.894242115136, 5303.0, 5306.230596563515, 5306.73466326686, 5316.521513063804, 24792.3801904952, 25220.621690674656, 26224.164308498413, 26323.0, 26385.208443746717, 2088.0, 2221.3224966385246, 2287.336672365012, 2526.84838909666, 2915.212892519008, 11722.648320550397, 12513.0, 13402.932985335108, 15209.847901520954, 15214.923925380413, 1736.6353065856185, 1740.416960318295, 1748.1521462090875, 1805.0523475175507, 1818.8999605021718, 116062.41968790187, 118820.0, 120821.5219554141, 124168.9999999991, 124647.0, 11543.480543375568, 11577.247478913843, 11641.301521908712, 11675.474603642857, 11837.76324473523, 15089.622759431102, 15199.544013679608, 15201.771973420407, 15214.619634509227, 15228.923855380652, 7330.816729581803, 8233.135520770353, 8579.14208579137, 8726.432781869285, 8755.299576033902, 7098.254683258184, 8521.744347669579, 8566.614502347285, 8679.305655547541, 8794.824103517894, 4577.542245775396, 4651.953480465219, 4654.930176047362, 4679.438467383868, 4716.764161791897, 1660.3275673352312, 1793.237873903612, 1869.793982881034, 1972.21111555379, 1992.5989183034408, 917.4586993673764, 927.7448701607112, 938.3759799733101, 1013.3312014070679, 1028.93311934724, 16440.035888744795, 19006.71489927652, 20018.69971950422, 20437.0, 20446.284380046924, 948.6347756113807, 958.1759686669459, 960.7406000379858, 969.8642190093393, 1022.3099407899638, 8907.643694252287, 10796.406197659204, 10824.567017319376, 10831.754348249895, 10838.945805270923, 579304.0, 583753.0812345911, 602792.986035067, 604593.0, 604865.0, 99885.0, 124515.0, 126785.0, 133516.66483335238, 137001.0, 969.6848524229654, 975.1711045611315, 985.4038306824411, 988.456349008057, 1014.7158795537409, 12827.551035713705, 15906.204689765696, 17299.7405038922, 17646.91176544109, 18436.539086522946, 47388.0, 50218.0, 50761.492385075675, 50845.0, 51939.740301298254, 73567.0, 73984.26015739773, 74312.0, 75779.62110189414, 77526.0, 7764.6894124234395, 8007.879881801661, 8009.239122283374, 8202.958985205036, 8555.101714320155, 12002.519899204284, 12298.81551776742, 12696.301703406401, 12716.0, 12782.23306601607, 10765.515551800032, 11025.338479691245, 11063.225574209728, 11082.335059896432, 11229.943850280697, 10524.31591946521, 10595.788084238426, 10627.628033018807, 10691.358518488916, 10729.409882456228, 11159.386233756897, 11317.0, 11356.375399353115, 11393.943030285127, 11527.942360288145, 7988.760337189894, 8073.15231900642, 8163.224493673091, 8381.161883811814, 8443.902292702156, 10563.0, 11006.394648294421, 11287.492062857027, 11340.94329528347, 11401.486933087865], "value": 9556.070015543384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8441471438134, 1622.4808061420347, 1634.713925063114, 1920.9807901920976, 2043.090824583061, 7035.36681698647, 7443.851122977537, 8565.528895910722, 8574.785630359243, 8581.785455363619, 8299.83400331993, 8324.83350332993, 8494.405391622573, 8502.319814414848, 8520.616572254248, 2144.453164443065, 2378.286514045788, 2406.506666133447, 2463.187148241076, 2466.6300054991716, 2455.398427385293, 2468.9259322220273, 2469.71598266199, 2475.121331927167, 2475.5915273979863, 2405.530921470314, 2430.647556104364, 2459.1270099114827, 2465.395977985387, 2469.5678256305164, 2147.5168087180414, 2361.6929799126005, 2401.6157414813633, 2408.927732168038, 2434.9513009739885, 2435.6468312094826, 2461.1263001634343, 2464.137551856854, 2464.1745015419856, 2473.1591258972035, 8391.11893251206, 8482.15178482153, 8487.490750554987, 8490.193431623986, 8490.872636910452, 5134.897302053975, 5282.867928301823, 5296.020236256305, 5334.67991920486, 5336.653117547347, 3308.106811160997, 3454.913627159316, 3623.257232267405, 3636.3636363636256, 3638.6543278388513, 1057.545255540125, 1058.4654749351605, 1061.4268295120703, 1063.7181146996052, 1079.4710591810035, 11064.225504214708, 11240.044596209333, 11331.886681133248, 11348.262362946465, 11359.602413915472, 4728.845359490797, 4801.063792560487, 4915.877103072452, 4918.975405122951, 4933.235348520985, 9876.703698889045, 10002.0, 10014.899851001543, 10025.649102281384, 10033.247506437046, 5247.921281180786, 5395.136778115482, 5396.62223644349, 5407.459254074561, 5418.45815418455, 4193.203291374629, 4376.212281789245, 4525.705829121162, 4551.52209018055, 4847.5394837490385, 3969.4244334571904, 4028.3353246713964, 4090.4886889138857, 4120.17596480705, 4123.113530590937, 1302.4659889445472, 1343.382044259632, 1350.648831303868, 1354.0995238166508, 1360.836699596035, 864.5720368417548, 877.5085951866974, 881.9196484306673, 957.3490026781856, 960.3229723045237, 5633.183188437653, 5800.738966746507, 5894.528437724972, 5909.349971503131, 5962.2249107615735, 447.4339959950665, 459.56341475598316, 465.8276437718066, 466.30753331302986, 472.15012976641907, 3865.4781604483596, 3929.017745563609, 3937.9212415751526, 4017.77902215381, 4048.4534587830854, 10003.149732272694, 10347.0, 10487.685369438928, 10582.100521455608, 10583.206259530565, 10422.791544169075, 10496.68509944703, 10502.947485262524, 10521.894781052091, 10522.789544209072, 7539.509931854412, 7917.524948503108, 7960.960195199103, 8112.0, 8112.107668156498, 5868.061110222344, 5872.324682661378, 5975.193348898017, 6015.218021657157, 6047.213862197887, 9386.5776040077, 9682.75793105178, 9752.0, 9758.804823903623, 9765.462899540593, 9476.431414115175, 9781.119699227103, 9894.505274736379, 10025.498725063864, 10032.799344013225, 6819.829504262433, 7027.121609798775, 7076.150861896605, 7184.8922266165, 7425.591592462466, 8059.0, 8076.0, 8173.100958894398, 8182.549959752271, 8188.50868947865, 7131.108611423572, 7279.272072792678, 7336.7798966031105, 7415.555066696015, 7427.665755041145, 7134.32223938725, 7148.28517148281, 7195.820104497429, 7218.458615603956, 7235.493515453868, 6749.662516874235, 6928.0, 6929.3070692930305, 6940.722371105099, 6953.33943275388, 4405.9559404405545, 4573.588377046081, 4853.320535125014, 4907.656464047483, 5062.797488100435, 4437.467503899553, 4773.188557945227, 4916.508349165055, 4955.231939049453, 5167.534921857051], "value": 4476.823189015963, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.38657311529073, 316.8431626344958, 324.6834336521893, 325.8321964188443, 329.37418904082256, 4341.630961368283, 4771.9761401192945, 4794.640401969848, 5136.614753893459, 5190.948090519094, 4511.887202819931, 5107.872303192422, 5150.69095854249, 5160.961420239003, 5168.3539557555305, 3067.9386412271797, 3877.595890547864, 3948.2893079245723, 4030.778307193103, 4038.7980600969836, 3308.073739352985, 3377.172592714788, 3729.832157552903, 4011.7994100295014, 4021.5375231848275, 3965.385365268374, 3965.5637879833193, 3985.083430810915, 3994.940075898864, 4003.0392705750555, 3620.71034317254, 3800.467934489174, 3886.7667939923695, 3916.902077448058, 3949.5584111799276, 3472.0625431133453, 3488.284901595167, 3494.5806503219524, 3503.8773642922374, 3525.77391686609, 4622.8905062785025, 4945.431275403339, 4963.528464795839, 4973.62697797663, 4992.575631071363, 4169.311428871312, 4291.77684359959, 4307.741535507879, 4382.627476664487, 4451.332300154971, 5027.773750181251, 5359.222912677679, 5384.542313903323, 5395.028894798935, 5420.915816836609, 3839.558450778168, 3847.4802453031175, 3851.2105018471148, 3852.2295540891655, 3854.653081222675, 4905.975470122627, 5477.5070243677865, 5661.716914154275, 5683.175939488792, 5710.400407957146, 3804.4048374286585, 3880.223955208913, 3881.6506514413836, 3897.9610203898164, 3905.746126501825, 3369.5114208440127, 3478.652134786552, 3587.6053634100226, 3795.791231482295, 3960.7821569813937, 4502.549745025472, 4525.321201819754, 4541.954580454153, 4547.15877562652, 4562.58936695699, 4541.72749635023, 5147.922781158286, 5211.869703257449, 5367.624266301322, 5541.722913854291, 1221.6701490597666, 1274.5093139141497, 1311.4557458654551, 1313.8700717383042, 1417.9861399099486, 861.8752527950959, 885.9335549833788, 915.3821170709745, 926.1063074133493, 949.8717673114041, 5009.949900500948, 5133.614978876599, 5139.280500729901, 5445.373782015119, 5461.01701693691, 5083.61872859537, 5463.104554586076, 5574.637648552831, 5616.354119276336, 5624.409437009137, 4351.738895666207, 4406.911861762746, 5080.441151473335, 5088.974555127201, 5108.055009823194, 2597.9610305845426, 3200.535922291255, 3220.243242837931, 3222.935541289208, 3247.918802029968, 5382.519807053013, 6259.311475737665, 6378.639903235832, 6385.2656944451055, 6421.165248517663, 5856.882862342814, 6295.496360291166, 6324.810255692337, 6354.459870910932, 6356.188486281388, 5853.326867410302, 6403.199600049994, 6404.455621272151, 6408.775692850728, 6423.74305027803, 5679.37526872052, 5843.883122337615, 6116.35778243278, 6193.194884664965, 6204.906926396017, 5096.668716533413, 6068.302145253176, 6092.933736596166, 6096.420840020191, 6125.356837531995, 5289.444608316071, 6265.686715664289, 6393.456556192589, 6407.583507072025, 6416.486681065597, 3999.8600048998146, 4038.51537815464, 4049.5140583130215, 4061.4923134608175, 4066.9389959150044, 6115.908261375994, 6127.540434467522, 6141.785037523665, 6159.306190797566, 6211.0, 5108.846734597968, 5484.561235101262, 5932.4957378621575, 5962.880742385215, 5976.282846058501, 5425.538829199562, 5442.455754424526, 5469.753861076181, 5494.36814766307, 5522.337319521683, 4325.24308246062, 4814.194676996127, 5112.412072611549, 5179.896402072013, 5402.243685883901, 4102.897427564335, 4649.139909116824, 4945.016529998742, 5163.535281824654, 5397.244385786072, 4800.951990480051, 5282.339707536558, 5407.78368865241, 5448.782048718007, 5449.782008719607], "value": 4106.595447764449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9718014099295, 573.7676241122347, 606.0666473948103, 606.7178761875729, 614.7233744814831, 14612.4885629003, 14680.412783488648, 15056.397744090236, 15058.322375493102, 15420.61448463789, 14199.574012779607, 14264.500742474016, 14312.0, 14336.139831610111, 14354.641133971656, 747.5141158247155, 768.7885831396355, 914.8307563100848, 927.9860802087974, 936.9203617692505, 941.7174847545743, 947.9951251673249, 952.3761935931941, 953.1374106433689, 959.3716115944068, 1005.4771518810251, 1007.4005966449951, 1010.8837483689359, 1011.3123076308108, 1012.8227560176977, 778.5562229529171, 962.3071388600197, 995.3778888194878, 999.6701088640731, 1000.3547711725932, 746.1642959884964, 747.6897087708594, 748.0985412577885, 748.913874904382, 750.5459197185679, 14757.704845903021, 14856.405743770236, 14879.851201487954, 14902.627434314121, 14921.552353429415, 12390.56633017849, 12486.81269780954, 12655.810162847565, 12657.936710316482, 12700.618981430573, 9093.363464557484, 9110.954445227731, 9151.359404841663, 9190.0, 9356.298277629205, 3463.5843698756057, 3474.513568100468, 3476.6001909780193, 3520.2783429396914, 3737.2808508086314, 78288.60855695685, 78922.0, 79091.6045419775, 79876.60061699654, 80039.799403009, 9226.53867306632, 9443.527823608792, 9448.291378146667, 9716.75708107303, 9758.463284519277, 21729.130834766747, 21765.891170544044, 21794.782052179275, 21802.672959905613, 22099.447513812283, 7294.489385742947, 7379.520331178456, 7423.777286681408, 7465.992091067745, 7615.390768738598, 3558.733095017884, 4004.839806407769, 4083.0813067060267, 4091.774952377648, 4106.507219133723, 3510.1575621851084, 3572.7499075065016, 3576.481410195559, 3578.7494875359, 3586.964130358663, 617.2222999021266, 622.707327556048, 633.341325021972, 652.3476523476523, 653.2422390027546, 539.7948779463857, 549.1844610753028, 549.5081901697957, 586.4135864135864, 615.4706952021259, 8051.436399451982, 8076.768498717369, 8228.711995080144, 8302.0, 8343.165683431609, 574.2878830250543, 582.7785441532191, 606.5178183344252, 607.1963647331638, 613.0742578706097, 3669.541307336583, 3682.779033258013, 3861.613838616116, 3883.902902427462, 3904.3362628353248, 82988.0, 87105.56447217724, 87169.0, 90774.0, 90780.0, 59910.70044649749, 76383.0, 76901.23098769052, 77996.61001694955, 80301.59849200833, 66748.66625666937, 68111.0, 68268.99999999901, 68403.0, 68638.0, 6888.621125838127, 7287.307705767944, 7696.7306144284685, 8472.389000443489, 8498.575071246289, 36001.81999089988, 42779.57220427756, 43441.565584345015, 44685.776571116934, 46025.0, 58244.12633810411, 67766.66116669386, 67985.66007169933, 68219.0, 70792.29207707857, 10883.510242038968, 11035.668929932115, 11218.607348742755, 11298.887011129784, 11324.660260192208, 11836.230645008047, 11904.880951190376, 11914.76170476603, 12289.385530723606, 12618.49526018949, 11315.321080735182, 11469.31184128955, 11720.413979301171, 11727.530898763955, 11800.881991179978, 11054.11567074616, 11217.383043932661, 11283.32300061966, 11301.886981130083, 11615.709607259887, 11202.775944480902, 11228.93325134111, 11251.887481125084, 11257.0, 11261.493232804707, 9715.951420242853, 9804.117629413387, 9891.901080989386, 9938.503074846085, 10037.0, 9458.148766611039, 9686.643572550633, 9710.126088651772, 9749.463779492196, 9934.751631209278], "value": 6810.426118772917, "unit": "score"}], "name": "dromaeo_css", "value": 7031.525980765871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 107.0, 113.0, 113.0, 112.0, 118.0, 114.0, 106.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 143.0, 171.0, 121.0, 145.0, 129.0, 149.0, 201.0, 141.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 187.0, 186.0, 185.0, 188.0, 185.0, 195.0, 185.0, 183.0], "value": 186.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 92.0, 92.0, 56.0, 59.0, 57.0, 83.0, 97.0, 56.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 138.0, 78.0, 81.0, 81.0, 121.0, 74.0, 78.0, 127.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 84.0, 89.0, 84.0, 84.0, 85.0, 87.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 86.0, 85.0, 86.0, 86.0, 87.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 57.0, 58.0, 58.0, 75.0, 59.0, 57.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 78.0, 74.0, 69.0, 68.0, 66.0, 68.0, 67.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 83.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 137.0, 134.0, 133.0, 139.0, 152.0, 149.0, 190.0, 136.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 171.0, 171.0, 169.0, 169.0, 168.0, 168.0, 168.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 68.0, 68.0, 69.0, 71.0, 70.0, 68.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1480.0, "alertThreshold": 2.0}]} 01:21:08 INFO - Return code: 0 01:21:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:21:08 ERROR - # TBPL SUCCESS # 01:21:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:21:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:21:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:21:08 INFO - 2016-04-29 01:21:08.533 screenresolution[2010:15791] starting screenresolution argv=screenresolution get 01:21:08 INFO - 2016-04-29 01:21:08.536 screenresolution[2010:15791] Display 0: 1600x1200x32@60 01:21:08 INFO - 2016-04-29 01:21:08.542 screenresolution[2011:15794] starting screenresolution argv=screenresolution list 01:21:08 INFO - Available Modes on Display 0 01:21:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:21:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:21:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:21:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:21:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:21:08 INFO - Intel Iris: 01:21:08 INFO - Chipset Model: Intel Iris 01:21:08 INFO - Type: GPU 01:21:08 INFO - Bus: Built-In 01:21:08 INFO - VRAM (Dynamic, Max): 1536 MB 01:21:08 INFO - Vendor: Intel (0x8086) 01:21:08 INFO - Device ID: 0x0a2e 01:21:08 INFO - Revision ID: 0x0009 01:21:08 INFO - Displays: 01:21:08 INFO - Display: 01:21:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:21:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:21:08 INFO - Display Serial Number: 1600x1200 60 01:21:08 INFO - Main Display: Yes 01:21:08 INFO - Mirror: Off 01:21:08 INFO - Online: Yes 01:21:08 INFO - Rotation: Supported 01:21:08 INFO - Return code: 0 01:21:08 INFO - Running post-action listener: _resource_record_post_action 01:21:08 INFO - Running post-run listener: _resource_record_post_run 01:21:09 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 750080; Write bytes: 693773824; Read time: 9; Write time: 2081 01:21:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385110528; Write bytes: 379078144; Read time: 28488; Write time: 776 01:21:09 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 750080; Write bytes: 294862848; Read time: 9; Write time: 1265 01:21:09 INFO - Running post-run listener: _upload_blobber_files 01:21:09 INFO - Blob upload gear active. 01:21:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:21:09 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 01:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:21:10 INFO - (blobuploader) - INFO - Open directory for files ... 01:21:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:21:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:21:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:11 INFO - (blobuploader) - INFO - Done attempting. 01:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:21:12 INFO - (blobuploader) - INFO - Done attempting. 01:21:12 INFO - (blobuploader) - INFO - Iteration through files over. 01:21:12 INFO - Return code: 0 01:21:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:21:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:21:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0bd5f61519d51e168f889e942c989a9e7f9aa9f20319b3e5416375c9d22251e878eee9b0107c994a300f84f80449cdc0256bde88f67b0f977a1eeaf905398a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53024ff9e1cabc5ed67469ae1068627e4bb3f9ce2e60e5fbeb978ce0c0008423488bf1d9a2f16d72986c0e58a4e7cd2d9961909acf6f17d301cebbc34d1ef296"} 01:21:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:21:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:21:12 INFO - Contents: 01:21:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0bd5f61519d51e168f889e942c989a9e7f9aa9f20319b3e5416375c9d22251e878eee9b0107c994a300f84f80449cdc0256bde88f67b0f977a1eeaf905398a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53024ff9e1cabc5ed67469ae1068627e4bb3f9ce2e60e5fbeb978ce0c0008423488bf1d9a2f16d72986c0e58a4e7cd2d9961909acf6f17d301cebbc34d1ef296"} 01:21:12 INFO - Running post-run listener: copy_logs_to_upload_dir 01:21:12 INFO - Copying logs to upload dir... 01:21:12 INFO - mkdir: /builds/slave/test/build/upload/logs 01:21:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.176369 ========= master_lag: 1.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-29 01:21:14.058004) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-29 01:21:14.067894) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0bd5f61519d51e168f889e942c989a9e7f9aa9f20319b3e5416375c9d22251e878eee9b0107c994a300f84f80449cdc0256bde88f67b0f977a1eeaf905398a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53024ff9e1cabc5ed67469ae1068627e4bb3f9ce2e60e5fbeb978ce0c0008423488bf1d9a2f16d72986c0e58a4e7cd2d9961909acf6f17d301cebbc34d1ef296"} build_url:https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/JuwkBO6xTMOjyULCIcNXNw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0bd5f61519d51e168f889e942c989a9e7f9aa9f20319b3e5416375c9d22251e878eee9b0107c994a300f84f80449cdc0256bde88f67b0f977a1eeaf905398a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53024ff9e1cabc5ed67469ae1068627e4bb3f9ce2e60e5fbeb978ce0c0008423488bf1d9a2f16d72986c0e58a4e7cd2d9961909acf6f17d301cebbc34d1ef296"}' ========= master_lag: 3.75 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-29 01:21:17.827942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:21:17.828291) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IR8hdbXKo1/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.aGVtUiVLtA/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005413 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 01:21:17.907564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 01:21:17.907866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 01:21:17.909036) ========= ========= Total master_lag: 5.74 =========