builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0052 starttime: 1456185126.72 results: success (0) buildid: 20160222144554 builduid: 0a656aee130746548f06a85e5d8a28bf revision: 1eefe1efe183078241b1401732e85550fbdcea94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.718586) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.719068) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.719362) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005782 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.745168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.745466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.763811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.764087) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005693 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.841421) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.844784) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.845192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:06.845482) ========= 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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-02-22 15:52:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 89.1M=0s 2016-02-22 15:52:07 (89.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216103 ========= master_lag: 0.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:07.461585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:07.461900) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.019917 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:07.502037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:52:07.502381) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1eefe1efe183078241b1401732e85550fbdcea94 --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 1eefe1efe183078241b1401732e85550fbdcea94 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-02-22 15:52:07,580 truncating revision to first 12 chars 2016-02-22 15:52:07,580 Setting DEBUG logging. 2016-02-22 15:52:07,580 attempt 1/10 2016-02-22 15:52:07,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1eefe1efe183?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 15:52:08,700 unpacking tar archive at: fx-team-1eefe1efe183/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:52:08.888832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:08.889182) ========= echo 1eefe1efe183078241b1401732e85550fbdcea94 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1eefe1efe183078241b1401732e85550fbdcea94'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 1eefe1efe183078241b1401732e85550fbdcea94 program finished with exit code 0 elapsedTime=0.005164 script_repo_revision: '1eefe1efe183078241b1401732e85550fbdcea94' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:08.938196) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:08.938502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:52:08.957672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-22 15:52:08.958015) ========= /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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52:09 INFO - MultiFileLogger online at 20160222 15:52:09 in /builds/slave/test 15:52:09 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 15:52:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:09 INFO - {'append_to_log': False, 15:52:09 INFO - 'base_work_dir': '/builds/slave/test', 15:52:09 INFO - 'blob_upload_branch': 'Fx-Team', 15:52:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:09 INFO - 'branch': 'Fx-Team', 15:52:09 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:09 INFO - 'config_files': ('talos/mac_config.py',), 15:52:09 INFO - 'default_actions': ('clobber', 15:52:09 INFO - 'read-buildbot-config', 15:52:09 INFO - 'download-and-extract', 15:52:09 INFO - 'populate-webroot', 15:52:09 INFO - 'create-virtualenv', 15:52:09 INFO - 'install', 15:52:09 INFO - 'run-tests'), 15:52:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:09 INFO - 'download_minidump_stackwalk': True, 15:52:09 INFO - 'download_symbols': 'ondemand', 15:52:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:09 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:09 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:09 INFO - 'installer_path': 'installer.exe', 15:52:09 INFO - 'log_level': 'info', 15:52:09 INFO - 'log_name': 'talos', 15:52:09 INFO - 'log_to_console': True, 15:52:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:09 INFO - 'opt_config_files': (), 15:52:09 INFO - 'pip_index': False, 15:52:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:09 INFO - 'cmd': ('bash', 15:52:09 INFO - '-c', 15:52:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:09 INFO - 'enabled': True, 15:52:09 INFO - 'halt_on_failure': False, 15:52:09 INFO - 'name': 'check_screen_resolution'},), 15:52:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:09 INFO - 'cmd': ('bash', 15:52:09 INFO - '-c', 15:52:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:09 INFO - 'enabled': True, 15:52:09 INFO - 'halt_on_failure': False, 15:52:09 INFO - 'name': 'check_screen_resolution'},), 15:52:09 INFO - 'run_cmd_checks_enabled': True, 15:52:09 INFO - 'sps_profile': False, 15:52:09 INFO - 'sps_profile_interval': 0, 15:52:09 INFO - 'suite': 'dromaeojs', 15:52:09 INFO - 'system_bits': '32', 15:52:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:09 INFO - 'title': 't-yosemite-r7-0052', 15:52:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:09 INFO - 'use_talos_json': True, 15:52:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:09 INFO - 'work_dir': 'build'} 15:52:09 INFO - ##### 15:52:09 INFO - ##### Running clobber step. 15:52:09 INFO - ##### 15:52:09 INFO - Running pre-action listener: _resource_record_pre_action 15:52:09 INFO - Running main action method: clobber 15:52:09 INFO - rmtree: /builds/slave/test/build 15:52:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:10 INFO - Running post-action listener: _resource_record_post_action 15:52:10 INFO - ##### 15:52:10 INFO - ##### Running read-buildbot-config step. 15:52:10 INFO - ##### 15:52:10 INFO - Running pre-action listener: _resource_record_pre_action 15:52:10 INFO - Running main action method: read_buildbot_config 15:52:10 INFO - Using buildbot properties: 15:52:10 INFO - { 15:52:10 INFO - "project": "", 15:52:10 INFO - "product": "firefox", 15:52:10 INFO - "script_repo_revision": "production", 15:52:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:52:10 INFO - "repository": "", 15:52:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:52:10 INFO - "buildid": "20160222144554", 15:52:10 INFO - "pgo_build": "False", 15:52:10 INFO - "basedir": "/builds/slave/test", 15:52:10 INFO - "buildnumber": 482, 15:52:10 INFO - "slavename": "t-yosemite-r7-0052", 15:52:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:52:10 INFO - "platform": "yosemite_r7", 15:52:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:52:10 INFO - "branch": "fx-team", 15:52:10 INFO - "repo_path": "integration/fx-team", 15:52:10 INFO - "revision": "1eefe1efe183078241b1401732e85550fbdcea94", 15:52:10 INFO - "stage_platform": "macosx64", 15:52:10 INFO - "builduid": "0a656aee130746548f06a85e5d8a28bf", 15:52:10 INFO - "slavebuilddir": "test" 15:52:10 INFO - } 15:52:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:52:10 INFO - Running post-action listener: _resource_record_post_action 15:52:10 INFO - ##### 15:52:10 INFO - ##### Running download-and-extract step. 15:52:10 INFO - ##### 15:52:10 INFO - Running pre-action listener: _resource_record_pre_action 15:52:10 INFO - Running main action method: download_and_extract 15:52:10 INFO - mkdir: /builds/slave/test/build/tests 15:52: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')]} 15:52:10 INFO - https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/test_packages.json 15:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/test_packages.json 15:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:52:11 INFO - Downloaded 1277 bytes. 15:52:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:52:11 INFO - Using the following test package requirements: 15:52:11 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:52:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:52:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:52:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'jsshell-mac.zip'], 15:52:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:52:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:52:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:52:11 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:52:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:52:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:52:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:52:11 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:52:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:11 INFO - https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:52:12 INFO - Downloaded 17825462 bytes. 15:52:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:52:15 INFO - Return code: 0 15:52:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:15 INFO - https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:52:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:52:16 INFO - Downloaded 17825462 bytes. 15:52:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:52:20 INFO - Return code: 0 15:52: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')]} 15:52:20 INFO - https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:52:21 INFO - Downloaded 10707015 bytes. 15:52:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:52:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:52:21 INFO - Return code: 0 15:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:21 INFO - https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 15:52:25 INFO - Downloaded 111278819 bytes. 15:52:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:52:25 INFO - mkdir: /builds/slave/test/properties 15:52:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:25 INFO - Contents: 15:52:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:52:26 INFO - Running post-action listener: _resource_record_post_action 15:52:26 INFO - Running post-action listener: set_extra_try_arguments 15:52:26 INFO - ##### 15:52:26 INFO - ##### Running populate-webroot step. 15:52:26 INFO - ##### 15:52:26 INFO - Running pre-action listener: _resource_record_pre_action 15:52:26 INFO - Running main action method: populate_webroot 15:52:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:26 INFO - '--tppagecycles', 15:52:26 INFO - '7'], 15:52:26 INFO - 'tests': ['tsvgm']}}, 15:52:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:52:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:52:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'tests': ['damp', 'tps']}, 15:52:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['damp', 'tps']}, 15:52:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:52:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:26 INFO - 'other': {'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'other_l64': {'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'other_nol64': {'tests': ['a11yr', 15:52:26 INFO - 'ts_paint', 15:52:26 INFO - 'tpaint', 15:52:26 INFO - 'sessionrestore', 15:52:26 INFO - 'sessionrestore_no_auto_restore']}, 15:52:26 INFO - 'svgr': {'tests': ['tsvgx', 15:52:26 INFO - 'tsvgr_opacity', 15:52:26 INFO - 'tart', 15:52:26 INFO - 'tscrollx', 15:52:26 INFO - 'cart']}, 15:52:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['tsvgx', 15:52:26 INFO - 'tsvgr_opacity', 15:52:26 INFO - 'tart', 15:52:26 INFO - 'tscrollx', 15:52:26 INFO - 'cart']}, 15:52:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'tests': ['tp5o']}, 15:52:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'talos_options': ['--e10s'], 15:52:26 INFO - 'tests': ['tp5o']}, 15:52:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'talos_options': ['--xperf_path', 15:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:26 INFO - 'tests': ['tp5n']}, 15:52:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:26 INFO - 'talos_options': ['--e10s', 15:52:26 INFO - '--xperf_path', 15:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:26 INFO - 'tests': ['tp5n']}}, 15:52:26 INFO - 'talos.zip': {'path': '', 15:52:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:26 INFO - Running post-action listener: _resource_record_post_action 15:52:26 INFO - ##### 15:52:26 INFO - ##### Running create-virtualenv step. 15:52:26 INFO - ##### 15:52:26 INFO - Running pre-action listener: _resource_record_pre_action 15:52:26 INFO - Running main action method: create_virtualenv 15:52:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:26 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 15:52:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:26 INFO - Using real prefix '/tools/python27' 15:52:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:29 INFO - Installing pip.................done. 15:52:29 INFO - Return code: 0 15:52:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:29 INFO - 'HOME': '/Users/cltbld', 15:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:29 INFO - 'LOGNAME': 'cltbld', 15:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:29 INFO - 'MOZ_NO_REMOTE': '1', 15:52:29 INFO - 'NO_EM_RESTART': '1', 15:52:29 INFO - 'PAGER': '/bin/cat', 15:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:29 INFO - 'PWD': '/builds/slave/test', 15:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:29 INFO - 'SHELL': '/bin/bash', 15:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:29 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:29 INFO - 'USER': 'cltbld', 15:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:29 INFO - 'XPC_FLAGS': '0x0', 15:52:29 INFO - 'XPC_SERVICE_NAME': '0', 15:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:30 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 15:52:30 INFO - Cleaning up... 15:52:30 INFO - Return code: 0 15:52:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:30 INFO - 'HOME': '/Users/cltbld', 15:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:30 INFO - 'LOGNAME': 'cltbld', 15:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:30 INFO - 'MOZ_NO_REMOTE': '1', 15:52:30 INFO - 'NO_EM_RESTART': '1', 15:52:30 INFO - 'PAGER': '/bin/cat', 15:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:30 INFO - 'PWD': '/builds/slave/test', 15:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:30 INFO - 'SHELL': '/bin/bash', 15:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:30 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:30 INFO - 'USER': 'cltbld', 15:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:30 INFO - 'XPC_FLAGS': '0x0', 15:52:30 INFO - 'XPC_SERVICE_NAME': '0', 15:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:30 INFO - Downloading/unpacking psutil>=0.7.1 15:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:32 INFO - Installing collected packages: psutil 15:52:32 INFO - Running setup.py install for psutil 15:52:33 INFO - building 'psutil._psutil_osx' extension 15:52:33 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 15:52:33 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 15:52:33 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 15:52:33 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 15:52:33 INFO - building 'psutil._psutil_posix' extension 15:52:33 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 15:52:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:52:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:52:33 INFO - ^ 15:52:33 INFO - 1 warning generated. 15:52:33 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 15:52:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:33 INFO - Successfully installed psutil 15:52:33 INFO - Cleaning up... 15:52:33 INFO - Return code: 0 15:52:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52: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 15:52: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 15:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:33 INFO - 'HOME': '/Users/cltbld', 15:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:33 INFO - 'LOGNAME': 'cltbld', 15:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:33 INFO - 'MOZ_NO_REMOTE': '1', 15:52:33 INFO - 'NO_EM_RESTART': '1', 15:52:33 INFO - 'PAGER': '/bin/cat', 15:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:33 INFO - 'PWD': '/builds/slave/test', 15:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:33 INFO - 'SHELL': '/bin/bash', 15:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:33 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:33 INFO - 'USER': 'cltbld', 15:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:33 INFO - 'XPC_FLAGS': '0x0', 15:52:33 INFO - 'XPC_SERVICE_NAME': '0', 15:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:34 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 15:52:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:36 INFO - Installing collected packages: mozsystemmonitor 15:52:36 INFO - Running setup.py install for mozsystemmonitor 15:52:36 INFO - Successfully installed mozsystemmonitor 15:52:36 INFO - Cleaning up... 15:52:36 INFO - Return code: 0 15:52:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52: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 15:52: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 15:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:36 INFO - 'HOME': '/Users/cltbld', 15:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:36 INFO - 'LOGNAME': 'cltbld', 15:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:36 INFO - 'MOZ_NO_REMOTE': '1', 15:52:36 INFO - 'NO_EM_RESTART': '1', 15:52:36 INFO - 'PAGER': '/bin/cat', 15:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:36 INFO - 'PWD': '/builds/slave/test', 15:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:36 INFO - 'SHELL': '/bin/bash', 15:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:36 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:36 INFO - 'USER': 'cltbld', 15:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:36 INFO - 'XPC_FLAGS': '0x0', 15:52:36 INFO - 'XPC_SERVICE_NAME': '0', 15:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:40 INFO - Downloading docopt-0.6.1.tar.gz 15:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:40 INFO - Running setup.py install for blobuploader 15:52:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:40 INFO - Running setup.py install for requests 15:52:41 INFO - Running setup.py install for docopt 15:52:41 INFO - Successfully installed blobuploader requests docopt 15:52:41 INFO - Cleaning up... 15:52:41 INFO - Return code: 0 15:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:41 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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52:41 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 15:52:41 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 15:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:41 INFO - 'HOME': '/Users/cltbld', 15:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:41 INFO - 'LOGNAME': 'cltbld', 15:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:41 INFO - 'MOZ_NO_REMOTE': '1', 15:52:41 INFO - 'NO_EM_RESTART': '1', 15:52:41 INFO - 'PAGER': '/bin/cat', 15:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:41 INFO - 'PWD': '/builds/slave/test', 15:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:41 INFO - 'SHELL': '/bin/bash', 15:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:41 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:41 INFO - 'USER': 'cltbld', 15:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:41 INFO - 'XPC_FLAGS': '0x0', 15:52:41 INFO - 'XPC_SERVICE_NAME': '0', 15:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-_DV1OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-iGAm4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-4hFXAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:41 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-0tcira-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HofR_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-k6IeCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ShvV3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-dofohd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-QZkfml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6p4J9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-lvtFuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-gH9w4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-joQWI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:42 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6UZZs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:43 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-VLi0OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:43 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Lbm5hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:43 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-gRT59x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:52:43 INFO - Running setup.py install for manifestparser 15:52:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:52:43 INFO - Running setup.py install for mozcrash 15:52:43 INFO - Running setup.py install for mozdebug 15:52:43 INFO - Running setup.py install for mozdevice 15:52:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:52:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Running setup.py install for mozfile 15:52:44 INFO - Running setup.py install for mozhttpd 15:52:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Running setup.py install for mozinfo 15:52:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Running setup.py install for mozInstall 15:52:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Running setup.py install for mozleak 15:52:44 INFO - Running setup.py install for mozlog 15:52:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:52:44 INFO - Running setup.py install for moznetwork 15:52:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Running setup.py install for mozprocess 15:52:45 INFO - Running setup.py install for mozprofile 15:52:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Running setup.py install for mozrunner 15:52:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Running setup.py install for mozscreenshot 15:52:45 INFO - Running setup.py install for moztest 15:52:45 INFO - Running setup.py install for mozversion 15:52:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:52:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:52:45 INFO - Cleaning up... 15:52:45 INFO - Return code: 0 15:52:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52: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 15:52: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 15:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:45 INFO - 'HOME': '/Users/cltbld', 15:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:45 INFO - 'LOGNAME': 'cltbld', 15:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:45 INFO - 'MOZ_NO_REMOTE': '1', 15:52:45 INFO - 'NO_EM_RESTART': '1', 15:52:45 INFO - 'PAGER': '/bin/cat', 15:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:45 INFO - 'PWD': '/builds/slave/test', 15:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:45 INFO - 'SHELL': '/bin/bash', 15:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:45 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:45 INFO - 'USER': 'cltbld', 15:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:45 INFO - 'XPC_FLAGS': '0x0', 15:52:45 INFO - 'XPC_SERVICE_NAME': '0', 15:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6wWzDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:46 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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-o4SFdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-fClkam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52: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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Tywqs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52: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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ota6wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52: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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-AHefio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52: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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-r5hI8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52: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)) 15:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:46 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-gdvI5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-leXqgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GUgXY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Mu8MwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:47 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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-6AOKwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52: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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-IvfRd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52: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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-L6DIb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52: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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-7SRsQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:52: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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-xFzWKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:52: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)) 15:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:52:47 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-bFrwht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:52:48 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)) 15:52:48 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:48 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:52:48 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)) 15:52:48 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)) 15:52:48 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)) 15:52:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:52:48 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 15:52:48 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 15:52:48 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 15:52:48 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 15:52:48 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 15:52:48 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 15:52:50 INFO - Downloading blessings-1.6.tar.gz 15:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:52:50 INFO - Installing collected packages: blessings 15:52:50 INFO - Running setup.py install for blessings 15:52:50 INFO - Successfully installed blessings 15:52:50 INFO - Cleaning up... 15:52:50 INFO - Return code: 0 15:52:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:50 INFO - Reading from file tmpfile_stdout 15:52:50 INFO - Current package versions: 15:52:50 INFO - blessings == 1.6 15:52:50 INFO - blobuploader == 1.2.4 15:52:50 INFO - docopt == 0.6.1 15:52:50 INFO - manifestparser == 1.1 15:52:50 INFO - mozInstall == 1.12 15:52:50 INFO - mozcrash == 0.16 15:52:50 INFO - mozdebug == 0.1 15:52:50 INFO - mozdevice == 0.48 15:52:50 INFO - mozfile == 1.2 15:52:50 INFO - mozhttpd == 0.7 15:52:50 INFO - mozinfo == 0.9 15:52:50 INFO - mozleak == 0.1 15:52:50 INFO - mozlog == 3.1 15:52:50 INFO - moznetwork == 0.27 15:52:50 INFO - mozprocess == 0.22 15:52:50 INFO - mozprofile == 0.28 15:52:50 INFO - mozrunner == 6.11 15:52:50 INFO - mozscreenshot == 0.1 15:52:50 INFO - mozsystemmonitor == 0.0 15:52:50 INFO - moztest == 0.7 15:52:50 INFO - mozversion == 1.4 15:52:50 INFO - psutil == 3.1.1 15:52:50 INFO - requests == 1.2.3 15:52:50 INFO - wsgiref == 0.1.2 15:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52: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 15:52: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 15:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:51 INFO - 'HOME': '/Users/cltbld', 15:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:51 INFO - 'LOGNAME': 'cltbld', 15:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:51 INFO - 'MOZ_NO_REMOTE': '1', 15:52:51 INFO - 'NO_EM_RESTART': '1', 15:52:51 INFO - 'PAGER': '/bin/cat', 15:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:51 INFO - 'PWD': '/builds/slave/test', 15:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:51 INFO - 'SHELL': '/bin/bash', 15:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:51 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:51 INFO - 'USER': 'cltbld', 15:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:51 INFO - 'XPC_FLAGS': '0x0', 15:52:51 INFO - 'XPC_SERVICE_NAME': '0', 15:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 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)) 15:52:51 INFO - Cleaning up... 15:52:51 INFO - Return code: 0 15:52:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:51 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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52:51 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 15:52:51 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 15:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:51 INFO - 'HOME': '/Users/cltbld', 15:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:51 INFO - 'LOGNAME': 'cltbld', 15:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:51 INFO - 'MOZ_NO_REMOTE': '1', 15:52:51 INFO - 'NO_EM_RESTART': '1', 15:52:51 INFO - 'PAGER': '/bin/cat', 15:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:51 INFO - 'PWD': '/builds/slave/test', 15:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:51 INFO - 'SHELL': '/bin/bash', 15:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:51 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:51 INFO - 'USER': 'cltbld', 15:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:51 INFO - 'XPC_FLAGS': '0x0', 15:52:51 INFO - 'XPC_SERVICE_NAME': '0', 15:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:51 INFO - Downloading/unpacking jsonschema 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:52:53 INFO - Downloading/unpacking functools32 (from jsonschema) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:52:54 INFO - warning: no files found matching '*.txt' 15:52:54 INFO - no previously-included directories found matching 'build' 15:52:54 INFO - no previously-included directories found matching 'dist' 15:52:54 INFO - no previously-included directories found matching '.git*' 15:52:54 INFO - Installing collected packages: jsonschema, functools32 15:52:54 INFO - Running setup.py install for functools32 15:52:54 INFO - warning: no files found matching '*.txt' 15:52:54 INFO - no previously-included directories found matching 'build' 15:52:54 INFO - no previously-included directories found matching 'dist' 15:52:54 INFO - no previously-included directories found matching '.git*' 15:52:54 INFO - Successfully installed jsonschema functools32 15:52:54 INFO - Cleaning up... 15:52:54 INFO - Return code: 0 15:52:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:52: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')]} 15:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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')]} 15:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52: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 0x10dc5da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc654c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7ebd93680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, '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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 15:52: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 15:52: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 15:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:54 INFO - 'HOME': '/Users/cltbld', 15:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:54 INFO - 'LOGNAME': 'cltbld', 15:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:54 INFO - 'MOZ_NO_REMOTE': '1', 15:52:54 INFO - 'NO_EM_RESTART': '1', 15:52:54 INFO - 'PAGER': '/bin/cat', 15:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:54 INFO - 'PWD': '/builds/slave/test', 15:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:54 INFO - 'SHELL': '/bin/bash', 15:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:52:54 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:54 INFO - 'USER': 'cltbld', 15:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:54 INFO - 'XPC_FLAGS': '0x0', 15:52:54 INFO - 'XPC_SERVICE_NAME': '0', 15:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:54 INFO - Downloading/unpacking flake8 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:52:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:52:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52: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 15:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:58 INFO - no previously-included directories found matching 'docs/_build' 15:52:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:52:58 INFO - Running setup.py install for pep8 15:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:52:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:52:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:52:58 INFO - no previously-included directories found matching 'docs/_build' 15:52:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:52:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:52:58 INFO - Cleaning up... 15:52:58 INFO - Return code: 0 15:52:58 INFO - Running post-action listener: _resource_record_post_action 15:52:58 INFO - Running post-action listener: _start_resource_monitoring 15:52:58 INFO - Starting resource monitoring. 15:52:58 INFO - ##### 15:52:58 INFO - ##### Running install step. 15:52:58 INFO - ##### 15:52:58 INFO - Running pre-action listener: _resource_record_pre_action 15:52:58 INFO - Running main action method: install 15:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:52:58 INFO - Reading from file tmpfile_stdout 15:52:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:52:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:52:59 INFO - Reading from file tmpfile_stdout 15:52:59 INFO - Output received: 15:52:59 INFO - Usage: mozinstall [options] installer 15:52:59 INFO - Options: 15:52:59 INFO - -h, --help show this help message and exit 15:52:59 INFO - -d DEST, --destination=DEST 15:52:59 INFO - Directory to install application into. [default: 15:52:59 INFO - "/builds/slave/test"] 15:52:59 INFO - --app=APP Application being installed. [default: firefox] 15:52:59 INFO - mkdir: /builds/slave/test/build/application 15:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:53:32 INFO - Reading from file tmpfile_stdout 15:53:32 INFO - Output received: 15:53:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:53:32 INFO - Running post-action listener: _resource_record_post_action 15:53:32 INFO - ##### 15:53:32 INFO - ##### Running run-tests step. 15:53:32 INFO - ##### 15:53:32 INFO - Running pre-action listener: _resource_record_pre_action 15:53:32 INFO - Running main action method: run_tests 15:53:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:53:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:53:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:53:32 INFO - 2016-02-22 15:53:32.528 screenresolution[1951:11990] starting screenresolution argv=screenresolution get 15:53:32 INFO - 2016-02-22 15:53:32.530 screenresolution[1951:11990] Display 0: 1600x1200x32@60 15:53:32 INFO - 2016-02-22 15:53:32.536 screenresolution[1952:11992] starting screenresolution argv=screenresolution list 15:53:32 INFO - Available Modes on Display 0 15:53:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:53:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:53:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:53:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:53:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:53:32 INFO - Intel Iris: 15:53:32 INFO - Chipset Model: Intel Iris 15:53:32 INFO - Type: GPU 15:53:32 INFO - Bus: Built-In 15:53:32 INFO - VRAM (Dynamic, Max): 1536 MB 15:53:32 INFO - Vendor: Intel (0x8086) 15:53:32 INFO - Device ID: 0x0a2e 15:53:32 INFO - Revision ID: 0x0009 15:53:32 INFO - Displays: 15:53:32 INFO - Display: 15:53:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:53:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:53:32 INFO - Display Serial Number: 1600x1200 60 15:53:32 INFO - Main Display: Yes 15:53:32 INFO - Mirror: Off 15:53:32 INFO - Online: Yes 15:53:32 INFO - Rotation: Supported 15:53:32 INFO - Return code: 0 15:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:32 INFO - Python 2.7.3 15:53:32 INFO - Return code: 0 15:53:32 INFO - grabbing minidump binary from tooltool 15:53: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')]} 15:53: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 0x10db01d30>, '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 0x10d925db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10daf8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53: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 15:53: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 15:53:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:32 INFO - Return code: 0 15:53:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:53:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:53:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:34 INFO - Return code: 0 15:53:34 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/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 15:53:34 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/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 15:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Gs4jKzPtBj/Render', 15:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:34 INFO - 'HOME': '/Users/cltbld', 15:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:34 INFO - 'LOGNAME': 'cltbld', 15:53:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:34 INFO - 'MOZ_NO_REMOTE': '1', 15:53:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:34 INFO - 'NO_EM_RESTART': '1', 15:53:34 INFO - 'PAGER': '/bin/cat', 15:53:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:34 INFO - 'PWD': '/builds/slave/test', 15:53:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:34 INFO - 'SHELL': '/bin/bash', 15:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yfAtPcccOT/Listeners', 15:53:34 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 15:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:34 INFO - 'USER': 'cltbld', 15:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:34 INFO - 'XPC_FLAGS': '0x0', 15:53:34 INFO - 'XPC_SERVICE_NAME': '0', 15:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:34 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/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 15:53:34 INFO - mozversion application_buildid: 20160222144554 15:53:34 INFO - mozversion application_changeset: 1eefe1efe183078241b1401732e85550fbdcea94 15:53:34 INFO - mozversion application_display_name: Nightly 15:53:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:34 INFO - mozversion application_name: Firefox 15:53:34 INFO - mozversion application_remotingname: firefox 15:53:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:53:34 INFO - mozversion application_vendor: Mozilla 15:53:34 INFO - mozversion application_version: 47.0a1 15:53:34 INFO - mozversion platform_buildid: 20160222144554 15:53:34 INFO - mozversion platform_changeset: 1eefe1efe183078241b1401732e85550fbdcea94 15:53:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:53:34 INFO - mozversion platform_version: 47.0a1 15:53:34 INFO - using testdate: 1456185214 15:53:34 INFO - actual date: 1456185214 15:53:34 INFO - starting webserver on 'localhost:49625' 15:53:34 INFO - SUITE-START | Running 2 tests 15:53:34 INFO - TEST-START | dromaeo_css 15:53:34 INFO - operating with platform_type : mac_ 15:53:34 INFO - Initialising browser for dromaeo_css test... 15:53:34 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp1kXpdD/profile http://localhost:49625/getInfo.html) 15:53:37 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 15:53:37 INFO - PROCESS | 1970 | colorDepth:24 15:53:37 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 15:53:37 INFO - PROCESS | 1970 | __metrics 15:53:37 INFO - PROCESS | 1970 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:53:37 INFO - PROCESS | 1970 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:53:38 INFO - TEST-INFO | 1970: exit 0 15:53:38 INFO - Browser initialized. 15:53:38 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:38 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp1kXpdD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:50 INFO - PROCESS | 1973 | RSS: Main: 242712576 15:53:50 INFO - PROCESS | 1973 | 15:54:41 INFO - PROCESS | 1973 | 1456185281202 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] 15:56:51 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49625/tests/dromaeo/cssquery-ext.html) 15:56:53 INFO - PROCESS | 1973 | RSS: Main: 339795968 15:56:53 INFO - PROCESS | 1973 | 15:59:55 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-ext.html (next: http://localhost:49625/tests/dromaeo/cssquery-jquery.html) 15:59:56 INFO - PROCESS | 1973 | RSS: Main: 379379712 15:59:56 INFO - PROCESS | 1973 | 16:02:58 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49625/tests/dromaeo/cssquery-mootools.html) 16:02:59 INFO - PROCESS | 1973 | RSS: Main: 380051456 16:02:59 INFO - PROCESS | 1973 | 16:06:01 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49625/tests/dromaeo/cssquery-prototype.html) 16:06:01 INFO - PROCESS | 1973 | RSS: Main: 336064512 16:06:01 INFO - PROCESS | 1973 | 16:09:04 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49625/tests/dromaeo/cssquery-yui.html) 16:09:05 INFO - PROCESS | 1973 | RSS: Main: 343552000 16:09:05 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:49625/tests/dromaeo/cssquery-yui.html (next: http://localhost:49625/tests/dromaeo/cssquery-dojo.html) 16:12:08 INFO - PROCESS | 1973 | RSS: Main: 439963648 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | __start_tp_report 16:12:08 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 16:12:08 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 16:12:08 INFO - PROCESS | 1973 | |i|pagename|runs| 16:12:08 INFO - PROCESS | 1973 | |0;dojo.html;3218.7425005999507;3337.749668774842;3415.3510832941747;3455.9654403455975;3466.861325546978;5588.692621905793;5674.290713660793;5683.204351390808;5709.800156994511;5718.685472299027;5661.405552416988;5676.687782171989;5714.885702285952;5807.041838096719;5810.5932584718985;4856;5056.721880296601;5119.718415487147;5121.12940800063;5221.608379371543;5178.404483484391;5187.351581052369;5242.79028838846;5260.947390526084;5292.894142117156;5038.546530812227;5069.949300506984;5156.123459011977;5159.14874045782;5227.11139106349;5122.129238029544;5147.202183661539;5156.432792392834;5162.354705661793;5175.353080864892;5095.541401273903;5134.589232861362;5139.948600513984;5162.612804039674;5172.069027575035;5526.392096869341;5567.721613919288;5605.962896864094;5607.887842243133;5617.971910140464;6101.352634788582;6125.78559750411;6211.503079753609;6222.471089957359;6227.906581401283;6244.094606282064;6286.402791734778;6308.779192728232;6319.905201421982;6333.809985700436;5609.915851262234;5817.069268916953;5820.330661973927;5823.272090988627;5833.387494313079;6216.067589861557;6252.6873656317;6323.778667746698;6323.873522529616;6330.905036424458;6107;6113.480354169857;6117.694115294217;6125.877482450326;6127.908081378783;6062.757489700362;6154.692265386713;6158.476529494954;6248;6248.187735594343;5147.1507201312115;6110.285381942539;6197.03945888388;6212.099245609361;6238.095476155932;6239.344868788802;6266.749330026748;6271.247450305901;6271.749130034838;6285.96857015712;4787.305840653085;4891.828785992473;4897.069556784199;4904.926426103611;4924.852254432372;4374.78126093694;4406.294992801137;4440.422745043188;4443.555644435595;4458.398116254329;5570.136628822458;5593.776248950077;5633.63381380209;5654.038813401731;5657.632253903483;6201.937980620136;6205.782797602153;6218.440340369298;6220.533459990519;6222.719977601018;4839.41926968766;5642.661440313512;5642.915356269659;5649.745761440745;5660.066089095336;5354.41101478837;5365.7585408656705;5373.194020896819;5376.193570964387;5423.2407462954425;6289.7484100636375;6313.526485513605;6340.270868850142;6365.809025729328;6373.74505019794;6301.905471417841;6303.936960630335;6309.3690630936535;6324.209473815773;6326.841828954313;6275.403836635513;6311.463525600376;6322.46259067966;6328.367163283635;6340.9048864268;6126.387361263838;6168.1056246844855;6203.410675985774;6206.906896396648;6214.130021797043;6237.875242495215;6293.937060629518;6295.559310848196;6296.653684047421;6310.021946598285;5922.970385148046;6006.699665016819;6075.453209211192;6077.058056001327;6108.4938477747555;6088.330283668882;6090.269167699905;6093.634381937098;6108.17539632144;6134.325224225421;5754.6547207167705;5896.380880007709;5938.851528711817;5945.227120474311;5961.046232602763;5944.554158438048;6042.818715438368;6126.908096378469;6134.04922237054;6143.96928015357;5954.553408494294;5961.552883533665;5977.103434484862;5983.192269043623;5988.580799344004 16:12:08 INFO - PROCESS | 1973 | |1;ext.html;452.377980277119;475.54347826086956;504.49046463072295;520.375549340791;585.1778251556565;37901.43147852781;38568.42147367792;38589.03527411813;38727.806360968156;38755.224895502106;40368.788936331955;40817;40924.59075409245;40958.59041409585;40988;9377.671781487632;9614;9619.422834629944;9632.325737198364;9656.324057315991;9451.905480945172;9588.23294136471;9603.223403670343;9604.615815367377;9613.759656008586;9687.903120968771;9721.951390243039;9741;9741.659041933533;9747.415155090683;9637.277204209677;9691.660791872286;9702.320837541374;9715.36850104741;9717.46553939533;9469.14777670013;9511.191548718367;9639.566219520138;9640.373375730554;9644.469554174517;40098.997525061815;40775.7961210195;40778.38832417486;40789;40790.79604601958;3165.3511030238747;3180.6325561098465;3216.2281052547455;3344.5317655528247;3469.7397695172713;28244.293892652644;28551.85724071387;28849.56725649117;30105.247368815737;30336.393272134654;2740.945181096387;2791.3161275487637;2793.6507936507937;2809.2836326736756;2816.9718302816914;515059;518621.4068929669;518988;520030;520535;45177.87055323578;45627.54372456233;45736.54263457323;67328.32671673318;67630.3236967624;44944.65166045024;45116;45345.77327113343;45368.77315613401;45404;15306.770398444032;15488.767668484981;15499.225038748244;15507.844921550866;15510.922445387701;12426.440810163564;12511.687207819696;12521.874781252252;12532.81200781989;12541.686457838627;14676.926615366854;14691.412343506354;14695.632609184855;14701.26493675312;14831.77752333716;6207.206756959386;6327.272363678144;6378.202724659418;6391.808245752635;6396.744130234832;883.9436872936778;1002.8946960569035;1005.9647912323034;1009.4851625670814;1156.4853640130061;29416.411671766444;29643;29712.55431168534;30318.242043949078;30320;977.6431602465191;986.8815742110849;1138.2658185470325;1144.4792619358172;1180.9645710628695;14041.087329323562;14601.707965840837;14817.481388151364;14986.400543978336;16116.274767635485;540731;545079;546714;547719;940222;60747.392526074174;61135;61342.38657613456;61496;61545.38454615486;1401.3257933392067;1453.9200343981183;1479.363873534369;1495.8504149584955;1501.481988713892;21656.458588535414;24040;28264.85867570649;31143.68856311408;31890.043298701075;53474.73262633662;53547;54202.728986354814;54419;54424;516706;521179;521458;523310;524394;32209.67790322067;32757.017289481355;33144.50283245801;33180;33238.50142247917;43247.783761080995;44024.779876100416;44108.558914410445;44474.77762611166;44674;35444.645553544135;36520.81739591285;36801.11196604511;37005.25989480141;37141;35831.46252806158;36431.817840910626;36812.447813282284;36818.26363472769;37047.81476092602;36251.45622815607;37333.253334932604;38231.2353752929;38415.42376864293;38530.0367490815;29518.96683616063;31902.202444939063;31945.361092777548;32038.67961320357;32079;24294.028238870247;25415.74584254134;25477;25499.980000800504;25888.093916712824 16:12:08 INFO - PROCESS | 1973 | |2;jquery.html;352.7864147333174;369.82063699105936;370.823858667133;380.6402949212993;382.46454963051707;15557.29992150353;16219.945703529293;19366;19811.702824457643;20889.47776305591;19962.900185499053;20417.59164816703;20671.896640516814;20708.171673133093;20749.585008299826;5558.499735023847;5594.328680558328;5811.564132690065;5815.73829177688;5920.97039514804;3885.32006898793;5681.005823980808;5734.770609175628;5939.168516407684;5945.821625351225;5941.732622031997;5954.910676339859;5968.074948383008;5973.701314934257;5974.761009559613;5662.584353911522;5950.97024514879;5959.553033522503;5964.463198312129;5982.611130276561;5616.129499927518;5661.1508273758855;5671.9716401418145;5672.149177623348;5681.147827825818;21254.043568039477;25167;25266.747332526622;25337.493250134896;25561;1862.7891870284288;2070.140891530013;2078.4699901525014;2099.454141923096;2441.292025312657;9602.807943841084;10242.334248273839;10489.527971241236;11977.341246231454;14413.855861441356;1684.7472879068116;1769.8938063716218;1783.4382169616658;1791.6864548703925;1799.0644864670428;96806.51596742042;102424.48787756014;103047;103891.48054259756;103946.96053039448;10556.736081598021;11009.61466348674;11121.666350009513;11262.943685281522;11286.435678216221;12241.387930603434;12529.248245105322;12831.615051548468;13501.864981350061;13510.932445337907;6830;8285.337173026144;8366.163383661707;8564.3148548116;8585.957070214608;8722.694705685271;8751.431156974777;8762.430442021376;8772;8821.911780882108;4378.8029538670835;4488.192125417456;4496.64026877849;4498.617617502484;4582.679212455163;1823.7355583440326;1876.6246750649925;1884.7078702801089;1917.9136938837785;1928.6914093745213;868.7654333329965;961.3222678011984;964.9324547281623;973.432773235091;1031.7730099378125;20308.69536956947;20347.287844925355;20465.38603841887;20530.791187806462;20533.2813351532;943.7923656795494;949.4920217683506;957.7940742740344;990.2770977186694;1015.5176291261591;7470.663820128108;8488.957555212184;10250.846237306447;11334.886651133547;11436.885631143748;603919;615391;620910;623463;626030;96428.0357196433;120180.3990980057;121793;126617.10074348892;127132.36433817772;895.6372669069037;903.8689390038408;928.359431991937;981.2787601113176;992.9553170107363;18600.441986740418;18873.811261887204;18897.811021889604;19128.84979246533;19249.422517324503;50165.49834501608;52008;52357;53043.734781325846;53132.46867531275;78570.42859142671;80705;80887.59556202182;81381;82207;7164.853623420227;7619.69521219145;8181.713640022571;8235.547044912348;8386.622601982803;12448.937755311166;12969.0819565597;13574.185548867099;13736.93131534336;13917.721645567235;11650.825237621273;11869;11886.762264754829;11911.106666999836;11930.463129159381;11351;11392.772144556897;11724.941375293069;11811.645650630495;11830.645080647595;10175.908259996639;11451.427428628702;11759.294442333487;12061.638150855488;12085.214461060003;6499.3175716549085;8177.877331840146;8252.133525979685;8258.29804466603;8279.089300177096;9658.951705241428;11955.342456164646;12045.51817927273;12073.637790866289;12097.57658481949 16:12:08 INFO - PROCESS | 1973 | |3;mootools.html;1412.547984644914;1512.8260250071241;1550.0467212664212;1780.6438712257543;1927.8843269403837;7013.912843509258;8389.580520973957;8454.87317690235;8467.407281490297;8492.19324164205;8360.372972027108;8626.784330391743;8642.092580279075;8644.394892357537;8648.35137364697;2174.521605246851;2442.7312995570474;2465.864377459239;2491.2277194069807;2507.523570521604;2469.3085935937966;2522.9747702523014;2524.798016158712;2528.6586310847983;2531.5696331623667;2493.2270995991303;2506.624006399046;2508.059477695864;2508.209913877132;2514.107491840398;2405.5549723301156;2491.9377015574573;2494.900203991838;2496.7378425265447;2500.2874180858457;2438.9390265243333;2481.702195736505;2482.056818409011;2482.838615489987;2489.825712200147;8759.51822649754;8818.559072046437;8825.69110081144;8848.159424854628;8850.645974161025;5381.892362152774;5491.862703432406;5535.916961245584;5538.833834984957;5545.417731138253;3229.095853161095;3596.2447885943984;3655.0314166745834;3670.449432585107;3679.025058359537;944.8488241881266;1052.3896140238644;1062.1396668698378;1096.4024606589348;1096.5175322857917;11771.7057073573;11848.992835608984;11869.94065029678;11883.989860861837;11895.286282822972;4949.57928576075;4971.701697898137;5020.3724534433195;5034.0686972910125;5046.697198168122;8515.14848515156;10123.493825308706;10126.645567405105;10129.848052279222;10152.289339746147;4989.875253118701;5483.341998960151;5500.009998200362;5529.778808847601;5534.418886016991;4596.448426188812;4602.9769851151195;4606.147862645421;4831.4685384607665;5030.220315851049;3326.8835590754693;3979.7612143271494;4007.959920400817;4036.59634036594;4060.5330387005283;1297.8118172864881;1314.2705798282045;1315.651352391617;1315.9998401215146;1344.1128854955682;1324.4966912573352;1340.886024687893;1352.2832898563777;1367.3231750283474;1369.4659082957655;8069;8253.298469630028;8262.752117436487;8262.876056859152;8263.710770123138;509.788437798317;517.2396577031757;525.3905469655182;525.6688286379633;528.0521463972179;6177.660228687376;6197.318294987548;6221.5333849961435;6250.218722659668;6257.09272155544;10413.635522756667;10736.946315268373;10889.673309800719;10900.50947707355;10903.509342079626;10483.842742358871;10589.258751887448;10612.628558000433;10731.463426828783;10739.946300268448;6861.4853885958755;7018.543794653331;8320.791980200422;8339.499630022217;8376.078631350547;7815.335696465864;7886.84226315459;7904.170062143622;7910.841783164419;7931.444798864024;9476.289278304017;9484.668036618685;9529.904700953179;9642.807143857224;9743.707688769347;9746.658866939906;9837.852432213665;9948.403095814274;10059.044390782863;10115.59537618487;6748.156480439945;6992.965035174791;7340.596267205355;7469.477136600386;7549.433792465697;8097.311728503143;8132.105468398589;8166.387520936072;8181.018277806701;8195.098539160568;7238.710451581877;7311.744088956861;7326.890096648661;7447.776566703008;7482.738104166328;7146.535475194096;7242.855142897218;7272.23641517633;7313.890291645524;7323.231060738546;7691.269329413697;7700.460967732429;7760.805979850549;7771.8834217485655;7783.260590243918;6973.232944376216;7037.894431583428;7071.045408869737;7075.71697132109;7079.221285658677;7093.964530177316;7130.358267755927;7150.7497237596435;7153.785386438415;7169.139703235645 16:12:08 INFO - PROCESS | 1973 | |4;prototype.html;326.2479983637715;334.74392090051117;339.67221631125966;340.1648951823274;346.65161512679754;6507.4143327100555;6571.901421478676;6573.83565410865;6579.835504112393;6601.108850305207;5124.9487505124935;6494.188226471691;6514.022896565506;6524.543281970264;6526.641034743087;4786.617070634358;4792.424909010915;4795.520447955211;4801.231802911535;4812.927806082912;3931.7051221158385;4806.534007127824;4811.687240329385;4819.759012049383;4823.782929768169;4412.095520418323;4480.372747815292;4724.5039270876405;4740.146773580754;4752.239641657336;4692.319613656035;4720.03239335937;4725.8582242532775;4735.550122738335;4758.952410475886;4076.3681629347498;4080.5511393746665;4085.366768150912;4089.141280331134;4108.732932359387;5949.583529152961;6065.150878876961;6178.783742568989;6215.844603884939;6224.595401298901;5665.603407761459;5666.914996275059;5676.489115979582;5684.033714268584;5698.629589076697;7004.2645522220455;7009.2990700929495;7012.859742805115;7017.3684368407085;7031.1211098612675;3771.41543060826;4640.443146822369;4644.396228490308;4654.976725116353;4655.138799322136;6964.129483814523;7081.398081163107;7089.9645501772675;7331.9266807332315;7339.266073392671;4562.654017064974;4596.448426188878;4605.125026245003;4637.072585482917;4702.412198475191;3932.2135572885536;4744.217204161344;4780.880477988008;4799.6400269979895;4802.759862006956;5608.607397482218;5623.044082505984;5623.409541998113;5696.344920334214;5704.087346024616;6250.718602686438;6463.289038205794;7035.788926332219;7039.753608623673;7042.0493233412835;1546;1624.4070914116262;1625.2361390146611;1634.4933070748107;1664.3592216996544;1026.7381817636456;1033.9379637221791;1043.3948309980344;1046.9371837689764;1057.6879820452984;5348.759305831247;6432.581882177644;6497.220333560003;6519.771807986698;6524.9673751630935;5871.4715675589405;6936.445084393337;7232.674529646073;7274.27257274279;7281.963590182015;5268.972550352721;6476.870462590722;6486.416222539994;6494.837629059217;6508;3823.617638236154;3843.655370224161;3890.3775395936514;3901.375779875263;3903.6486716195677;6945.47908906834;7035.33164349386;7507.948887155802;7518.774436766906;7523.510971786816;7344.375728063174;7394.001809755721;7396.482246242819;7401;7407.444441666788;6341;7489.438292128003;7494.85010299791;7499.362554182846;7507.286807753146;5752.511036561939;7173.892391614026;7187.173475050227;7200.207977122408;7200.71197152108;6746.932530674827;7066.681999309941;7069.505134640526;7075.327843854826;7085;7427.851442971002;7482.064741907262;7496.437767167376;7499.1750907399055;7501.612201742695;4361.629261512807;4508.1659892919915;4586.220342541709;4590.724556526619;4698.718076915396;7174.497785154989;7177.533460325062;7185.568865868065;7195.172555156015;7217.711291548279;6966.442684585119;6967.163940327193;6982.162140543167;6984.092068031124;6987.196472405535;6952.582845029315;6957.582545047313;6970.093887794555;6976.6860491277;6978.232394436506;6510.707018184288;6803.7618683345845;6819.795406137824;6839.452843772586;6844.965775171092;6919.169699636076;6956.130483689539;6959.791206263618;6963.61700106499;6981.79054628362;6172.783952561639;6826.795196144124;6839.076724642109;6841.418479429304;6848.383645471732 16:12:08 INFO - PROCESS | 1973 | |5;yui.html;687.618371803649;701.7508784381548;707.734599525178;722.5881247688819;770.4221833624781;14376.784348234785;14620.415183392652;14637.194954277511;14653.120812751242;14662.560123196294;13527;13574.864251357483;13610.319484025784;13612.931935340333;13633.727325453485;708.1572928215433;721.7221369772649;723.5405517496375;724.5507785173173;872.136584781067;720.125048066599;865.1780808232173;887.7647423432795;890.0698769785589;894.7047474333455;929.1776777551847;942.5617088054054;942.8774259346276;943.386798580921;945.5083356654535;937.0535758883509;937.1237892570468;938.8779458670364;939.8026414453008;944.0606596436555;553.4548469757286;562.4488001758259;564.4468420947494;678.8981652752077;695.214407719279;14204.076735012191;14260.429582816674;14262.286885655676;14280.357383917748;14284.000119991604;12409;12496.437660305308;12605.810912836314;12724;12828.871711282862;8141.307988820958;9897.604095836157;10180.074650571785;10214.28500005;10670.413127277996;3410.641882602316;3565.964340356589;3590.35373632746;3631.0740761106013;3661.9084522886874;82066.58966705248;82598.58700706458;82633;82639;82667;9651.131398174057;9668.951655241819;9822.361546499455;9859.457729824928;10275.177985761122;21063.8946805265;21326.78673213248;21341.679874801892;21360;21567.352979410643;7345.485815992829;7424.487889239038;7521.661525231378;7673.386129109658;7792.571408572469;4076.5515793262716;4107.301758701028;4119.958800412018;4143.606357396043;4151.543330233671;3532.2582257725653;3549.982250088733;3561.8041007744823;3573.0531409176588;3577.731670124751;626.0827887145354;630.4011189370117;630.8391360203119;651.8598501322239;665.0556210181554;562.943705629442;602.3885755957706;618.2056057965493;622.4926684751913;640.8494003909078;8451.873221901677;8561.614727337284;8590.44041243714;8719.956400218085;8831.779205519784;541.228749032627;546.819549548648;575.140165452651;602.8733965867217;614.4469977020627;3839.577646458943;3985.880423587297;4111.9103437589065;4227.87316380509;4348.108637729258;82625.17374826295;96670;96802;96904.51547742357;97097.02902971022;79447;81337.59331203306;81452;81699;83104;71773;72225.27774722186;72474.63762681259;72816.54366912632;73110.6344468285;8622.870656940277;8712.607932642919;8979.236764875059;9010.369274150746;9024.503652298923;49664.00671986468;49895;49974.25038624351;51259.74370128125;52443;66152.00771988327;69935.30064699288;70257;71956;72224.63887680738;11357.204995650556;11357.37534435614;11598.88401115978;11807;11995.700107497383;8716.171963663443;11290.548378064785;11905.404729763304;12028.917397434272;12375.62873113808;9155.26757859383;11663.88336116628;11792.174547781573;11943.462544185359;12039.03687704999;11503.309801411942;11806.82289765637;11875.682059408433;11895.226810257305;11895.286282823059;9357.069736086543;11344.319340839576;11377.203595748219;11527.88472115268;12429.316387598768;9260.212881904845;9576.90423095788;9639.518024098907;9755.317127800985;9896.50517474109;7426.962865185856;9369.471164567802;9979.591938070846;10032.097111260022;10139.594416223563 16:12:08 INFO - PROCESS | 1973 | __end_tp_report 16:12:08 INFO - PROCESS | 1973 | __start_cc_report 16:12:08 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,1040 16:12:08 INFO - PROCESS | 1973 | __end_cc_report 16:12:08 INFO - PROCESS | 1973 | __startTimestamp1456186328470__endTimestamp 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | ------- Summary: start ------- 16:12:08 INFO - PROCESS | 1973 | Number of tests: 6 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#0] dojo.html Cycles:165 Average:5719.00 Median:5954.55 stddev:653.97 (11.0%) stddev-sans-first:625.88 16:12:08 INFO - PROCESS | 1973 | Values: 3218.7 3337.7 3415.4 3456.0 3466.9 5588.7 5674.3 5683.2 5709.8 5718.7 5661.4 5676.7 5714.9 5807.0 5810.6 4856.0 5056.7 5119.7 5121.1 5221.6 5178.4 5187.4 5242.8 5260.9 5292.9 5038.5 5069.9 5156.1 5159.1 5227.1 5122.1 5147.2 5156.4 5162.4 5175.4 5095.5 5134.6 5139.9 5162.6 5172.1 5526.4 5567.7 5606.0 5607.9 5618.0 6101.4 6125.8 6211.5 6222.5 6227.9 6244.1 6286.4 6308.8 6319.9 6333.8 5609.9 5817.1 5820.3 5823.3 5833.4 6216.1 6252.7 6323.8 6323.9 6330.9 6107.0 6113.5 6117.7 6125.9 6127.9 6062.8 6154.7 6158.5 6248.0 6248.2 5147.2 6110.3 6197.0 6212.1 6238.1 6239.3 6266.7 6271.2 6271.7 6286.0 4787.3 4891.8 4897.1 4904.9 4924.9 4374.8 4406.3 4440.4 4443.6 4458.4 5570.1 5593.8 5633.6 5654.0 5657.6 6201.9 6205.8 6218.4 6220.5 6222.7 4839.4 5642.7 5642.9 5649.7 5660.1 5354.4 5365.8 5373.2 5376.2 5423.2 6289.7 6313.5 6340.3 6365.8 6373.7 6301.9 6303.9 6309.4 6324.2 6326.8 6275.4 6311.5 6322.5 6328.4 6340.9 6126.4 6168.1 6203.4 6206.9 6214.1 6237.9 6293.9 6295.6 6296.7 6310.0 5923.0 6006.7 6075.5 6077.1 6108.5 6088.3 6090.3 6093.6 6108.2 6134.3 5754.7 5896.4 5938.9 5945.2 5961.0 5944.6 6042.8 6126.9 6134.0 6144.0 5954.6 5961.6 5977.1 5983.2 5988.6 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#1] ext.html Cycles:180 Average:68122.13 Median:38741.52 stddev:151114.67 (390.1%) stddev-sans-first:151453.18 16:12:08 INFO - PROCESS | 1973 | Values: 452.4 475.5 504.5 520.4 585.2 37901.4 38568.4 38589.0 38727.8 38755.2 40368.8 40817.0 40924.6 40958.6 40988.0 9377.7 9614.0 9619.4 9632.3 9656.3 9451.9 9588.2 9603.2 9604.6 9613.8 9687.9 9722.0 9741.0 9741.7 9747.4 9637.3 9691.7 9702.3 9715.4 9717.5 9469.1 9511.2 9639.6 9640.4 9644.5 40099.0 40775.8 40778.4 40789.0 40790.8 3165.4 3180.6 3216.2 3344.5 3469.7 28244.3 28551.9 28849.6 30105.2 30336.4 2740.9 2791.3 2793.7 2809.3 2817.0 515059.0 518621.4 518988.0 520030.0 520535.0 45177.9 45627.5 45736.5 67328.3 67630.3 44944.7 45116.0 45345.8 45368.8 45404.0 15306.8 15488.8 15499.2 15507.8 15510.9 12426.4 12511.7 12521.9 12532.8 12541.7 14676.9 14691.4 14695.6 14701.3 14831.8 6207.2 6327.3 6378.2 6391.8 6396.7 883.9 1002.9 1006.0 1009.5 1156.5 29416.4 29643.0 29712.6 30318.2 30320.0 977.6 986.9 1138.3 1144.5 1181.0 14041.1 14601.7 14817.5 14986.4 16116.3 540731.0 545079.0 546714.0 547719.0 940222.0 60747.4 61135.0 61342.4 61496.0 61545.4 1401.3 1453.9 1479.4 1495.9 1501.5 21656.5 24040.0 28264.9 31143.7 31890.0 53474.7 53547.0 54202.7 54419.0 54424.0 516706.0 521179.0 521458.0 523310.0 524394.0 32209.7 32757.0 33144.5 33180.0 33238.5 43247.8 44024.8 44108.6 44474.8 44674.0 35444.6 36520.8 36801.1 37005.3 37141.0 35831.5 36431.8 36812.4 36818.3 37047.8 36251.5 37333.3 38231.2 38415.4 38530.0 29519.0 31902.2 31945.4 32038.7 32079.0 24294.0 25415.7 25477.0 25500.0 25888.1 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#2] jquery.html Cycles:180 Average:34832.00 Median:12956.89 stddev:102469.65 (790.9%) stddev-sans-first:102724.39 16:12:08 INFO - PROCESS | 1973 | Values: 352.8 369.8 370.8 380.6 382.5 15557.3 16219.9 19366.0 19811.7 20889.5 19962.9 20417.6 20671.9 20708.2 20749.6 5558.5 5594.3 5811.6 5815.7 5921.0 3885.3 5681.0 5734.8 5939.2 5945.8 5941.7 5954.9 5968.1 5973.7 5974.8 5662.6 5951.0 5959.6 5964.5 5982.6 5616.1 5661.2 5672.0 5672.1 5681.1 21254.0 25167.0 25266.7 25337.5 25561.0 1862.8 2070.1 2078.5 2099.5 2441.3 9602.8 10242.3 10489.5 11977.3 14413.9 1684.7 1769.9 1783.4 1791.7 1799.1 96806.5 102424.5 103047.0 103891.5 103947.0 10556.7 11009.6 11121.7 11262.9 11286.4 12241.4 12529.2 12831.6 13501.9 13510.9 6830.0 8285.3 8366.2 8564.3 8586.0 8722.7 8751.4 8762.4 8772.0 8821.9 4378.8 4488.2 4496.6 4498.6 4582.7 1823.7 1876.6 1884.7 1917.9 1928.7 868.8 961.3 964.9 973.4 1031.8 20308.7 20347.3 20465.4 20530.8 20533.3 943.8 949.5 957.8 990.3 1015.5 7470.7 8489.0 10250.8 11334.9 11436.9 603919.0 615391.0 620910.0 623463.0 626030.0 96428.0 120180.4 121793.0 126617.1 127132.4 895.6 903.9 928.4 981.3 993.0 18600.4 18873.8 18897.8 19128.8 19249.4 50165.5 52008.0 52357.0 53043.7 53132.5 78570.4 80705.0 80887.6 81381.0 82207.0 7164.9 7619.7 8181.7 8235.5 8386.6 12448.9 12969.1 13574.2 13736.9 13917.7 11650.8 11869.0 11886.8 11911.1 11930.5 11351.0 11392.8 11724.9 11811.6 11830.6 10175.9 11451.4 11759.3 12061.6 12085.2 6499.3 8177.9 8252.1 8258.3 8279.1 9659.0 11955.3 12045.5 12073.6 12097.6 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#3] mootools.html Cycles:180 Average:6015.28 Median:2954.97 stddev:3178.74 (107.6%) stddev-sans-first:3168.82 16:12:08 INFO - PROCESS | 1973 | Values: 1412.5 1512.8 1550.0 1780.6 1927.9 7013.9 8389.6 8454.9 8467.4 8492.2 8360.4 8626.8 8642.1 8644.4 8648.4 2174.5 2442.7 2465.9 2491.2 2507.5 2469.3 2523.0 2524.8 2528.7 2531.6 2493.2 2506.6 2508.1 2508.2 2514.1 2405.6 2491.9 2494.9 2496.7 2500.3 2438.9 2481.7 2482.1 2482.8 2489.8 8759.5 8818.6 8825.7 8848.2 8850.6 5381.9 5491.9 5535.9 5538.8 5545.4 3229.1 3596.2 3655.0 3670.4 3679.0 944.8 1052.4 1062.1 1096.4 1096.5 11771.7 11849.0 11869.9 11884.0 11895.3 4949.6 4971.7 5020.4 5034.1 5046.7 8515.1 10123.5 10126.6 10129.8 10152.3 4989.9 5483.3 5500.0 5529.8 5534.4 4596.4 4603.0 4606.1 4831.5 5030.2 3326.9 3979.8 4008.0 4036.6 4060.5 1297.8 1314.3 1315.7 1316.0 1344.1 1324.5 1340.9 1352.3 1367.3 1369.5 8069.0 8253.3 8262.8 8262.9 8263.7 509.8 517.2 525.4 525.7 528.1 6177.7 6197.3 6221.5 6250.2 6257.1 10413.6 10736.9 10889.7 10900.5 10903.5 10483.8 10589.3 10612.6 10731.5 10739.9 6861.5 7018.5 8320.8 8339.5 8376.1 7815.3 7886.8 7904.2 7910.8 7931.4 9476.3 9484.7 9529.9 9642.8 9743.7 9746.7 9837.9 9948.4 10059.0 10115.6 6748.2 6993.0 7340.6 7469.5 7549.4 8097.3 8132.1 8166.4 8181.0 8195.1 7238.7 7311.7 7326.9 7447.8 7482.7 7146.5 7242.9 7272.2 7313.9 7323.2 7691.3 7700.5 7760.8 7771.9 7783.3 6973.2 7037.9 7071.0 7075.7 7079.2 7094.0 7130.4 7150.7 7153.8 7169.1 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#4] prototype.html Cycles:180 Average:5654.07 Median:6481.64 stddev:1802.03 (27.8%) stddev-sans-first:1762.16 16:12:08 INFO - PROCESS | 1973 | Values: 326.2 334.7 339.7 340.2 346.7 6507.4 6571.9 6573.8 6579.8 6601.1 5124.9 6494.2 6514.0 6524.5 6526.6 4786.6 4792.4 4795.5 4801.2 4812.9 3931.7 4806.5 4811.7 4819.8 4823.8 4412.1 4480.4 4724.5 4740.1 4752.2 4692.3 4720.0 4725.9 4735.6 4759.0 4076.4 4080.6 4085.4 4089.1 4108.7 5949.6 6065.2 6178.8 6215.8 6224.6 5665.6 5666.9 5676.5 5684.0 5698.6 7004.3 7009.3 7012.9 7017.4 7031.1 3771.4 4640.4 4644.4 4655.0 4655.1 6964.1 7081.4 7090.0 7331.9 7339.3 4562.7 4596.4 4605.1 4637.1 4702.4 3932.2 4744.2 4780.9 4799.6 4802.8 5608.6 5623.0 5623.4 5696.3 5704.1 6250.7 6463.3 7035.8 7039.8 7042.0 1546.0 1624.4 1625.2 1634.5 1664.4 1026.7 1033.9 1043.4 1046.9 1057.7 5348.8 6432.6 6497.2 6519.8 6525.0 5871.5 6936.4 7232.7 7274.3 7282.0 5269.0 6476.9 6486.4 6494.8 6508.0 3823.6 3843.7 3890.4 3901.4 3903.6 6945.5 7035.3 7507.9 7518.8 7523.5 7344.4 7394.0 7396.5 7401.0 7407.4 6341.0 7489.4 7494.9 7499.4 7507.3 5752.5 7173.9 7187.2 7200.2 7200.7 6746.9 7066.7 7069.5 7075.3 7085.0 7427.9 7482.1 7496.4 7499.2 7501.6 4361.6 4508.2 4586.2 4590.7 4698.7 7174.5 7177.5 7185.6 7195.2 7217.7 6966.4 6967.2 6982.2 6984.1 6987.2 6952.6 6957.6 6970.1 6976.7 6978.2 6510.7 6803.8 6819.8 6839.5 6845.0 6919.2 6956.1 6959.8 6963.6 6981.8 6172.8 6826.8 6839.1 6841.4 6848.4 16:12:08 INFO - PROCESS | 1973 | 16:12:08 INFO - PROCESS | 1973 | [#5] yui.html Cycles:180 Average:18625.21 Median:628.24 stddev:26471.39 (4213.6%) stddev-sans-first:26511.38 16:12:08 INFO - PROCESS | 1973 | Values: 687.6 701.8 707.7 722.6 770.4 14376.8 14620.4 14637.2 14653.1 14662.6 13527.0 13574.9 13610.3 13612.9 13633.7 708.2 721.7 723.5 724.6 872.1 720.1 865.2 887.8 890.1 894.7 929.2 942.6 942.9 943.4 945.5 937.1 937.1 938.9 939.8 944.1 553.5 562.4 564.4 678.9 695.2 14204.1 14260.4 14262.3 14280.4 14284.0 12409.0 12496.4 12605.8 12724.0 12828.9 8141.3 9897.6 10180.1 10214.3 10670.4 3410.6 3566.0 3590.4 3631.1 3661.9 82066.6 82598.6 82633.0 82639.0 82667.0 9651.1 9669.0 9822.4 9859.5 10275.2 21063.9 21326.8 21341.7 21360.0 21567.4 7345.5 7424.5 7521.7 7673.4 7792.6 4076.6 4107.3 4120.0 4143.6 4151.5 3532.3 3550.0 3561.8 3573.1 3577.7 626.1 630.4 630.8 651.9 665.1 562.9 602.4 618.2 622.5 640.8 8451.9 8561.6 8590.4 8720.0 8831.8 541.2 546.8 575.1 602.9 614.4 3839.6 3985.9 4111.9 4227.9 4348.1 82625.2 96670.0 96802.0 96904.5 97097.0 79447.0 81337.6 81452.0 81699.0 83104.0 71773.0 72225.3 72474.6 72816.5 73110.6 8622.9 8712.6 8979.2 9010.4 9024.5 49664.0 49895.0 49974.3 51259.7 52443.0 66152.0 69935.3 70257.0 71956.0 72224.6 11357.2 11357.4 11598.9 11807.0 11995.7 8716.2 11290.5 11905.4 12028.9 12375.6 9155.3 11663.9 11792.2 11943.5 12039.0 11503.3 11806.8 11875.7 11895.2 11895.3 9357.1 11344.3 11377.2 11527.9 12429.3 9260.2 9576.9 9639.5 9755.3 9896.5 7427.0 9369.5 9979.6 10032.1 10139.6 16:12:08 INFO - PROCESS | 1973 | -------- Summary: end -------- 16:12:08 INFO - PROCESS | 1973 | 16:12:09 INFO - TEST-INFO | 1973: exit 0 16:12:09 INFO - TEST-OK | dromaeo_css | took 1114239ms 16:12:09 INFO - TEST-START | kraken 16:12:09 INFO - operating with platform_type : mac_ 16:12:09 INFO - Initialising browser for kraken test... 16:12:09 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpVYeqMY/profile http://localhost:49625/getInfo.html) 16:12:11 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 16:12:11 INFO - PROCESS | 1976 | colorDepth:24 16:12:11 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 16:12:11 INFO - PROCESS | 1976 | __metrics 16:12:11 INFO - PROCESS | 1976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:12:11 INFO - PROCESS | 1976 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:11 INFO - TEST-INFO | 1976: exit 0 16:12:11 INFO - Browser initialized. 16:12:11 INFO - Running cycle 1/1 for kraken test... 16:12:11 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpVYeqMY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:24 INFO - PROCESS | 1978 | RSS: Main: 242790400 16:12:24 INFO - PROCESS | 1978 | 16:12:26 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:27 INFO - PROCESS | 1978 | RSS: Main: 291581952 16:12:27 INFO - PROCESS | 1978 | 16:12:29 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-dft) 16:12:30 INFO - PROCESS | 1978 | RSS: Main: 299749376 16:12:30 INFO - PROCESS | 1978 | 16:12:33 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-fft) 16:12:34 INFO - PROCESS | 1978 | RSS: Main: 286609408 16:12:34 INFO - PROCESS | 1978 | 16:12:36 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator) 16:12:36 INFO - PROCESS | 1978 | RSS: Main: 290304000 16:12:36 INFO - PROCESS | 1978 | 16:12:39 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:39 INFO - PROCESS | 1978 | RSS: Main: 289460224 16:12:39 INFO - PROCESS | 1978 | 16:12:42 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:42 INFO - PROCESS | 1978 | RSS: Main: 289128448 16:12:42 INFO - PROCESS | 1978 | 16:12:45 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:46 INFO - PROCESS | 1978 | RSS: Main: 289841152 16:12:46 INFO - PROCESS | 1978 | 16:12:49 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial) 16:12:49 INFO - PROCESS | 1978 | RSS: Main: 289824768 16:12:49 INFO - PROCESS | 1978 | 16:12:51 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:52 INFO - PROCESS | 1978 | RSS: Main: 326995968 16:12:52 INFO - PROCESS | 1978 | 16:12:53 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:54 INFO - PROCESS | 1978 | RSS: Main: 324939776 16:12:54 INFO - PROCESS | 1978 | 16:12:56 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:57 INFO - PROCESS | 1978 | RSS: Main: 332255232 16:12:57 INFO - PROCESS | 1978 | 16:12:59 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:00 INFO - PROCESS | 1978 | RSS: Main: 333496320 16:13:00 INFO - PROCESS | 1978 | 16:13:02 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:03 INFO - PROCESS | 1978 | RSS: Main: 333328384 16:13:03 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49625/tests/kraken/driver.html?testName=ai-astar) 16:13:05 INFO - PROCESS | 1978 | RSS: Main: 394092544 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | __start_tp_report 16:13:05 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 16:13:05 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 16:13:05 INFO - PROCESS | 1978 | |i|pagename|runs| 16:13:05 INFO - PROCESS | 1978 | |0;ai-astar;112;107;110;110;112;112;115;108;103;109 16:13:05 INFO - PROCESS | 1978 | |1;audio-beat-detection;179;124;147;160;120;145;141;119;156;117 16:13:05 INFO - PROCESS | 1978 | |2;audio-dft;186;183;187;185;183;184;185;185;181;184 16:13:05 INFO - PROCESS | 1978 | |3;audio-fft;79;79;85;82;77;84;86;112;77;57 16:13:05 INFO - PROCESS | 1978 | |4;audio-oscillator;97;128;166;109;78;83;116;79;79;119 16:13:05 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;85;94;86;91;84;89;84;89;85;91 16:13:05 INFO - PROCESS | 1978 | |6;imaging-darkroom;93;93;93;93;94;93;93;93;93;92 16:13:05 INFO - PROCESS | 1978 | |7;imaging-desaturate;85;85;85;85;96;72;127;134;134;86 16:13:05 INFO - PROCESS | 1978 | |8;json-parse-financial;55;55;54;60;81;80;80;94;50;51 16:13:05 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;63;63;79;73;69;66;66;69;70;67 16:13:05 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;82;84;87;82;83;82;81;82;82;84 16:13:05 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;122;124;124;132;118;117;124;118;125;126 16:13:05 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;136;127;140;138;139;128;138;140;139;172 16:13:05 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;67;69;67;79 16:13:05 INFO - PROCESS | 1978 | __end_tp_report 16:13:05 INFO - PROCESS | 1978 | __start_cc_report 16:13:05 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,1166 16:13:05 INFO - PROCESS | 1978 | __end_cc_report 16:13:05 INFO - PROCESS | 1978 | __startTimestamp1456186385474__endTimestamp 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | ------- Summary: start ------- 16:13:05 INFO - PROCESS | 1978 | Number of tests: 14 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:3.43 16:13:05 INFO - PROCESS | 1978 | Values: 112.0 107.0 110.0 110.0 112.0 112.0 115.0 108.0 103.0 109.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:146.00 stddev:20.74 (14.2%) stddev-sans-first:16.77 16:13:05 INFO - PROCESS | 1978 | Values: 179.0 124.0 147.0 160.0 120.0 145.0 141.0 119.0 156.0 117.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:1.70 (0.9%) stddev-sans-first:1.69 16:13:05 INFO - PROCESS | 1978 | Values: 186.0 183.0 187.0 185.0 183.0 184.0 185.0 185.0 181.0 184.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:81.80 Median:80.50 stddev:13.42 (16.7%) stddev-sans-first:14.20 16:13:05 INFO - PROCESS | 1978 | Values: 79.0 79.0 85.0 82.0 77.0 84.0 86.0 112.0 77.0 57.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:78.50 stddev:28.30 (36.1%) stddev-sans-first:29.86 16:13:05 INFO - PROCESS | 1978 | Values: 97.0 128.0 166.0 109.0 78.0 83.0 116.0 79.0 79.0 119.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:89.00 stddev:3.49 (3.9%) stddev-sans-first:3.55 16:13:05 INFO - PROCESS | 1978 | Values: 85.0 94.0 86.0 91.0 84.0 89.0 84.0 89.0 85.0 91.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:13:05 INFO - PROCESS | 1978 | Values: 93.0 93.0 93.0 93.0 94.0 93.0 93.0 93.0 93.0 92.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:98.90 Median:85.00 stddev:23.39 (27.5%) stddev-sans-first:24.26 16:13:05 INFO - PROCESS | 1978 | Values: 85.0 85.0 85.0 85.0 96.0 72.0 127.0 134.0 134.0 86.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:70.00 stddev:16.00 (22.9%) stddev-sans-first:16.47 16:13:05 INFO - PROCESS | 1978 | Values: 55.0 55.0 54.0 60.0 81.0 80.0 80.0 94.0 50.0 51.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:4.81 (7.0%) stddev-sans-first:4.68 16:13:05 INFO - PROCESS | 1978 | Values: 63.0 63.0 79.0 73.0 69.0 66.0 66.0 69.0 70.0 67.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:1.73 (2.1%) stddev-sans-first:1.80 16:13:05 INFO - PROCESS | 1978 | Values: 82.0 84.0 87.0 82.0 83.0 82.0 81.0 82.0 82.0 84.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:124.00 stddev:4.52 (3.6%) stddev-sans-first:4.78 16:13:05 INFO - PROCESS | 1978 | Values: 122.0 124.0 124.0 132.0 118.0 117.0 124.0 118.0 125.0 126.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.70 Median:139.00 stddev:12.30 (8.9%) stddev-sans-first:12.98 16:13:05 INFO - PROCESS | 1978 | Values: 136.0 127.0 140.0 138.0 139.0 128.0 138.0 140.0 139.0 172.0 16:13:05 INFO - PROCESS | 1978 | 16:13:05 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:3.88 (5.8%) stddev-sans-first:4.09 16:13:05 INFO - PROCESS | 1978 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 67.0 69.0 67.0 79.0 16:13:05 INFO - PROCESS | 1978 | -------- Summary: end -------- 16:13:05 INFO - PROCESS | 1978 | 16:13:06 INFO - TEST-INFO | 1978: exit 0 16:13:06 INFO - TEST-OK | kraken | took 57200ms 16:13:06 INFO - SUITE-END | took 1171s 16:13:06 INFO - Completed test suite (00:19:31) 16:13:06 INFO - Working with test: dromaeo_css 16:13:06 INFO - Generating results file: dromaeo_css 16:13:06 INFO - Working with test: kraken 16:13:06 INFO - Generating results file: kraken 16:13:06 INFO - javascript benchmark 16:13:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:13:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:13:06 INFO - process_Request line: dromaeo_css 7476.15 graph.html#tests=[[72,64,59]] 16:13:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:13:07 INFO - process_Request line: kraken 1450.10 graph.html#tests=[[232,64,59]] 16:13:07 INFO - RETURN: dromaeo_css: 7476.15 16:13:07 INFO - RETURN: kraken: 1450.10 16:13:07 INFO - javascript benchmark 16:13:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3218.7425005999507, 3337.749668774842, 3415.3510832941747, 3455.9654403455975, 3466.861325546978, 5588.692621905793, 5674.290713660793, 5683.204351390808, 5709.800156994511, 5718.685472299027, 5661.405552416988, 5676.687782171989, 5714.885702285952, 5807.041838096719, 5810.5932584718985, 4856.0, 5056.721880296601, 5119.718415487147, 5121.12940800063, 5221.608379371543, 5178.404483484391, 5187.351581052369, 5242.79028838846, 5260.947390526084, 5292.894142117156, 5038.546530812227, 5069.949300506984, 5156.123459011977, 5159.14874045782, 5227.11139106349, 5122.129238029544, 5147.202183661539, 5156.432792392834, 5162.354705661793, 5175.353080864892, 5095.541401273903, 5134.589232861362, 5139.948600513984, 5162.612804039674, 5172.069027575035, 5526.392096869341, 5567.721613919288, 5605.962896864094, 5607.887842243133, 5617.971910140464, 6101.352634788582, 6125.78559750411, 6211.503079753609, 6222.471089957359, 6227.906581401283, 6244.094606282064, 6286.402791734778, 6308.779192728232, 6319.905201421982, 6333.809985700436, 5609.915851262234, 5817.069268916953, 5820.330661973927, 5823.272090988627, 5833.387494313079, 6216.067589861557, 6252.6873656317, 6323.778667746698, 6323.873522529616, 6330.905036424458, 6107.0, 6113.480354169857, 6117.694115294217, 6125.877482450326, 6127.908081378783, 6062.757489700362, 6154.692265386713, 6158.476529494954, 6248.0, 6248.187735594343, 5147.1507201312115, 6110.285381942539, 6197.03945888388, 6212.099245609361, 6238.095476155932, 6239.344868788802, 6266.749330026748, 6271.247450305901, 6271.749130034838, 6285.96857015712, 4787.305840653085, 4891.828785992473, 4897.069556784199, 4904.926426103611, 4924.852254432372, 4374.78126093694, 4406.294992801137, 4440.422745043188, 4443.555644435595, 4458.398116254329, 5570.136628822458, 5593.776248950077, 5633.63381380209, 5654.038813401731, 5657.632253903483, 6201.937980620136, 6205.782797602153, 6218.440340369298, 6220.533459990519, 6222.719977601018, 4839.41926968766, 5642.661440313512, 5642.915356269659, 5649.745761440745, 5660.066089095336, 5354.41101478837, 5365.7585408656705, 5373.194020896819, 5376.193570964387, 5423.2407462954425, 6289.7484100636375, 6313.526485513605, 6340.270868850142, 6365.809025729328, 6373.74505019794, 6301.905471417841, 6303.936960630335, 6309.3690630936535, 6324.209473815773, 6326.841828954313, 6275.403836635513, 6311.463525600376, 6322.46259067966, 6328.367163283635, 6340.9048864268, 6126.387361263838, 6168.1056246844855, 6203.410675985774, 6206.906896396648, 6214.130021797043, 6237.875242495215, 6293.937060629518, 6295.559310848196, 6296.653684047421, 6310.021946598285, 5922.970385148046, 6006.699665016819, 6075.453209211192, 6077.058056001327, 6108.4938477747555, 6088.330283668882, 6090.269167699905, 6093.634381937098, 6108.17539632144, 6134.325224225421, 5754.6547207167705, 5896.380880007709, 5938.851528711817, 5945.227120474311, 5961.046232602763, 5944.554158438048, 6042.818715438368, 6126.908096378469, 6134.04922237054, 6143.96928015357, 5954.553408494294, 5961.552883533665, 5977.103434484862, 5983.192269043623, 5988.580799344004], "unit": "score", "name": "dojo.html", "value": 5676.41968379201}, {"lowerIsBetter": false, "replicates": [452.377980277119, 475.54347826086956, 504.49046463072295, 520.375549340791, 585.1778251556565, 37901.43147852781, 38568.42147367792, 38589.03527411813, 38727.806360968156, 38755.224895502106, 40368.788936331955, 40817.0, 40924.59075409245, 40958.59041409585, 40988.0, 9377.671781487632, 9614.0, 9619.422834629944, 9632.325737198364, 9656.324057315991, 9451.905480945172, 9588.23294136471, 9603.223403670343, 9604.615815367377, 9613.759656008586, 9687.903120968771, 9721.951390243039, 9741.0, 9741.659041933533, 9747.415155090683, 9637.277204209677, 9691.660791872286, 9702.320837541374, 9715.36850104741, 9717.46553939533, 9469.14777670013, 9511.191548718367, 9639.566219520138, 9640.373375730554, 9644.469554174517, 40098.997525061815, 40775.7961210195, 40778.38832417486, 40789.0, 40790.79604601958, 3165.3511030238747, 3180.6325561098465, 3216.2281052547455, 3344.5317655528247, 3469.7397695172713, 28244.293892652644, 28551.85724071387, 28849.56725649117, 30105.247368815737, 30336.393272134654, 2740.945181096387, 2791.3161275487637, 2793.6507936507937, 2809.2836326736756, 2816.9718302816914, 515059.0, 518621.4068929669, 518988.0, 520030.0, 520535.0, 45177.87055323578, 45627.54372456233, 45736.54263457323, 67328.32671673318, 67630.3236967624, 44944.65166045024, 45116.0, 45345.77327113343, 45368.77315613401, 45404.0, 15306.770398444032, 15488.767668484981, 15499.225038748244, 15507.844921550866, 15510.922445387701, 12426.440810163564, 12511.687207819696, 12521.874781252252, 12532.81200781989, 12541.686457838627, 14676.926615366854, 14691.412343506354, 14695.632609184855, 14701.26493675312, 14831.77752333716, 6207.206756959386, 6327.272363678144, 6378.202724659418, 6391.808245752635, 6396.744130234832, 883.9436872936778, 1002.8946960569035, 1005.9647912323034, 1009.4851625670814, 1156.4853640130061, 29416.411671766444, 29643.0, 29712.55431168534, 30318.242043949078, 30320.0, 977.6431602465191, 986.8815742110849, 1138.2658185470325, 1144.4792619358172, 1180.9645710628695, 14041.087329323562, 14601.707965840837, 14817.481388151364, 14986.400543978336, 16116.274767635485, 540731.0, 545079.0, 546714.0, 547719.0, 940222.0, 60747.392526074174, 61135.0, 61342.38657613456, 61496.0, 61545.38454615486, 1401.3257933392067, 1453.9200343981183, 1479.363873534369, 1495.8504149584955, 1501.481988713892, 21656.458588535414, 24040.0, 28264.85867570649, 31143.68856311408, 31890.043298701075, 53474.73262633662, 53547.0, 54202.728986354814, 54419.0, 54424.0, 516706.0, 521179.0, 521458.0, 523310.0, 524394.0, 32209.67790322067, 32757.017289481355, 33144.50283245801, 33180.0, 33238.50142247917, 43247.783761080995, 44024.779876100416, 44108.558914410445, 44474.77762611166, 44674.0, 35444.645553544135, 36520.81739591285, 36801.11196604511, 37005.25989480141, 37141.0, 35831.46252806158, 36431.817840910626, 36812.447813282284, 36818.26363472769, 37047.81476092602, 36251.45622815607, 37333.253334932604, 38231.2353752929, 38415.42376864293, 38530.0367490815, 29518.96683616063, 31902.202444939063, 31945.361092777548, 32038.67961320357, 32079.0, 24294.028238870247, 25415.74584254134, 25477.0, 25499.980000800504, 25888.093916712824], "unit": "score", "name": "ext.html", "value": 19339.607324984543}, {"lowerIsBetter": false, "replicates": [352.7864147333174, 369.82063699105936, 370.823858667133, 380.6402949212993, 382.46454963051707, 15557.29992150353, 16219.945703529293, 19366.0, 19811.702824457643, 20889.47776305591, 19962.900185499053, 20417.59164816703, 20671.896640516814, 20708.171673133093, 20749.585008299826, 5558.499735023847, 5594.328680558328, 5811.564132690065, 5815.73829177688, 5920.97039514804, 3885.32006898793, 5681.005823980808, 5734.770609175628, 5939.168516407684, 5945.821625351225, 5941.732622031997, 5954.910676339859, 5968.074948383008, 5973.701314934257, 5974.761009559613, 5662.584353911522, 5950.97024514879, 5959.553033522503, 5964.463198312129, 5982.611130276561, 5616.129499927518, 5661.1508273758855, 5671.9716401418145, 5672.149177623348, 5681.147827825818, 21254.043568039477, 25167.0, 25266.747332526622, 25337.493250134896, 25561.0, 1862.7891870284288, 2070.140891530013, 2078.4699901525014, 2099.454141923096, 2441.292025312657, 9602.807943841084, 10242.334248273839, 10489.527971241236, 11977.341246231454, 14413.855861441356, 1684.7472879068116, 1769.8938063716218, 1783.4382169616658, 1791.6864548703925, 1799.0644864670428, 96806.51596742042, 102424.48787756014, 103047.0, 103891.48054259756, 103946.96053039448, 10556.736081598021, 11009.61466348674, 11121.666350009513, 11262.943685281522, 11286.435678216221, 12241.387930603434, 12529.248245105322, 12831.615051548468, 13501.864981350061, 13510.932445337907, 6830.0, 8285.337173026144, 8366.163383661707, 8564.3148548116, 8585.957070214608, 8722.694705685271, 8751.431156974777, 8762.430442021376, 8772.0, 8821.911780882108, 4378.8029538670835, 4488.192125417456, 4496.64026877849, 4498.617617502484, 4582.679212455163, 1823.7355583440326, 1876.6246750649925, 1884.7078702801089, 1917.9136938837785, 1928.6914093745213, 868.7654333329965, 961.3222678011984, 964.9324547281623, 973.432773235091, 1031.7730099378125, 20308.69536956947, 20347.287844925355, 20465.38603841887, 20530.791187806462, 20533.2813351532, 943.7923656795494, 949.4920217683506, 957.7940742740344, 990.2770977186694, 1015.5176291261591, 7470.663820128108, 8488.957555212184, 10250.846237306447, 11334.886651133547, 11436.885631143748, 603919.0, 615391.0, 620910.0, 623463.0, 626030.0, 96428.0357196433, 120180.3990980057, 121793.0, 126617.10074348892, 127132.36433817772, 895.6372669069037, 903.8689390038408, 928.359431991937, 981.2787601113176, 992.9553170107363, 18600.441986740418, 18873.811261887204, 18897.811021889604, 19128.84979246533, 19249.422517324503, 50165.49834501608, 52008.0, 52357.0, 53043.734781325846, 53132.46867531275, 78570.42859142671, 80705.0, 80887.59556202182, 81381.0, 82207.0, 7164.853623420227, 7619.69521219145, 8181.713640022571, 8235.547044912348, 8386.622601982803, 12448.937755311166, 12969.0819565597, 13574.185548867099, 13736.93131534336, 13917.721645567235, 11650.825237621273, 11869.0, 11886.762264754829, 11911.106666999836, 11930.463129159381, 11351.0, 11392.772144556897, 11724.941375293069, 11811.645650630495, 11830.645080647595, 10175.908259996639, 11451.427428628702, 11759.294442333487, 12061.638150855488, 12085.214461060003, 6499.3175716549085, 8177.877331840146, 8252.133525979685, 8258.29804466603, 8279.089300177096, 9658.951705241428, 11955.342456164646, 12045.51817927273, 12073.637790866289, 12097.57658481949], "unit": "score", "name": "jquery.html", "value": 9438.248421599603}, {"lowerIsBetter": false, "replicates": [1412.547984644914, 1512.8260250071241, 1550.0467212664212, 1780.6438712257543, 1927.8843269403837, 7013.912843509258, 8389.580520973957, 8454.87317690235, 8467.407281490297, 8492.19324164205, 8360.372972027108, 8626.784330391743, 8642.092580279075, 8644.394892357537, 8648.35137364697, 2174.521605246851, 2442.7312995570474, 2465.864377459239, 2491.2277194069807, 2507.523570521604, 2469.3085935937966, 2522.9747702523014, 2524.798016158712, 2528.6586310847983, 2531.5696331623667, 2493.2270995991303, 2506.624006399046, 2508.059477695864, 2508.209913877132, 2514.107491840398, 2405.5549723301156, 2491.9377015574573, 2494.900203991838, 2496.7378425265447, 2500.2874180858457, 2438.9390265243333, 2481.702195736505, 2482.056818409011, 2482.838615489987, 2489.825712200147, 8759.51822649754, 8818.559072046437, 8825.69110081144, 8848.159424854628, 8850.645974161025, 5381.892362152774, 5491.862703432406, 5535.916961245584, 5538.833834984957, 5545.417731138253, 3229.095853161095, 3596.2447885943984, 3655.0314166745834, 3670.449432585107, 3679.025058359537, 944.8488241881266, 1052.3896140238644, 1062.1396668698378, 1096.4024606589348, 1096.5175322857917, 11771.7057073573, 11848.992835608984, 11869.94065029678, 11883.989860861837, 11895.286282822972, 4949.57928576075, 4971.701697898137, 5020.3724534433195, 5034.0686972910125, 5046.697198168122, 8515.14848515156, 10123.493825308706, 10126.645567405105, 10129.848052279222, 10152.289339746147, 4989.875253118701, 5483.341998960151, 5500.009998200362, 5529.778808847601, 5534.418886016991, 4596.448426188812, 4602.9769851151195, 4606.147862645421, 4831.4685384607665, 5030.220315851049, 3326.8835590754693, 3979.7612143271494, 4007.959920400817, 4036.59634036594, 4060.5330387005283, 1297.8118172864881, 1314.2705798282045, 1315.651352391617, 1315.9998401215146, 1344.1128854955682, 1324.4966912573352, 1340.886024687893, 1352.2832898563777, 1367.3231750283474, 1369.4659082957655, 8069.0, 8253.298469630028, 8262.752117436487, 8262.876056859152, 8263.710770123138, 509.788437798317, 517.2396577031757, 525.3905469655182, 525.6688286379633, 528.0521463972179, 6177.660228687376, 6197.318294987548, 6221.5333849961435, 6250.218722659668, 6257.09272155544, 10413.635522756667, 10736.946315268373, 10889.673309800719, 10900.50947707355, 10903.509342079626, 10483.842742358871, 10589.258751887448, 10612.628558000433, 10731.463426828783, 10739.946300268448, 6861.4853885958755, 7018.543794653331, 8320.791980200422, 8339.499630022217, 8376.078631350547, 7815.335696465864, 7886.84226315459, 7904.170062143622, 7910.841783164419, 7931.444798864024, 9476.289278304017, 9484.668036618685, 9529.904700953179, 9642.807143857224, 9743.707688769347, 9746.658866939906, 9837.852432213665, 9948.403095814274, 10059.044390782863, 10115.59537618487, 6748.156480439945, 6992.965035174791, 7340.596267205355, 7469.477136600386, 7549.433792465697, 8097.311728503143, 8132.105468398589, 8166.387520936072, 8181.018277806701, 8195.098539160568, 7238.710451581877, 7311.744088956861, 7326.890096648661, 7447.776566703008, 7482.738104166328, 7146.535475194096, 7242.855142897218, 7272.23641517633, 7313.890291645524, 7323.231060738546, 7691.269329413697, 7700.460967732429, 7760.805979850549, 7771.8834217485655, 7783.260590243918, 6973.232944376216, 7037.894431583428, 7071.045408869737, 7075.71697132109, 7079.221285658677, 7093.964530177316, 7130.358267755927, 7150.7497237596435, 7153.785386438415, 7169.139703235645], "unit": "score", "name": "mootools.html", "value": 4836.499801268099}, {"lowerIsBetter": false, "replicates": [326.2479983637715, 334.74392090051117, 339.67221631125966, 340.1648951823274, 346.65161512679754, 6507.4143327100555, 6571.901421478676, 6573.83565410865, 6579.835504112393, 6601.108850305207, 5124.9487505124935, 6494.188226471691, 6514.022896565506, 6524.543281970264, 6526.641034743087, 4786.617070634358, 4792.424909010915, 4795.520447955211, 4801.231802911535, 4812.927806082912, 3931.7051221158385, 4806.534007127824, 4811.687240329385, 4819.759012049383, 4823.782929768169, 4412.095520418323, 4480.372747815292, 4724.5039270876405, 4740.146773580754, 4752.239641657336, 4692.319613656035, 4720.03239335937, 4725.8582242532775, 4735.550122738335, 4758.952410475886, 4076.3681629347498, 4080.5511393746665, 4085.366768150912, 4089.141280331134, 4108.732932359387, 5949.583529152961, 6065.150878876961, 6178.783742568989, 6215.844603884939, 6224.595401298901, 5665.603407761459, 5666.914996275059, 5676.489115979582, 5684.033714268584, 5698.629589076697, 7004.2645522220455, 7009.2990700929495, 7012.859742805115, 7017.3684368407085, 7031.1211098612675, 3771.41543060826, 4640.443146822369, 4644.396228490308, 4654.976725116353, 4655.138799322136, 6964.129483814523, 7081.398081163107, 7089.9645501772675, 7331.9266807332315, 7339.266073392671, 4562.654017064974, 4596.448426188878, 4605.125026245003, 4637.072585482917, 4702.412198475191, 3932.2135572885536, 4744.217204161344, 4780.880477988008, 4799.6400269979895, 4802.759862006956, 5608.607397482218, 5623.044082505984, 5623.409541998113, 5696.344920334214, 5704.087346024616, 6250.718602686438, 6463.289038205794, 7035.788926332219, 7039.753608623673, 7042.0493233412835, 1546.0, 1624.4070914116262, 1625.2361390146611, 1634.4933070748107, 1664.3592216996544, 1026.7381817636456, 1033.9379637221791, 1043.3948309980344, 1046.9371837689764, 1057.6879820452984, 5348.759305831247, 6432.581882177644, 6497.220333560003, 6519.771807986698, 6524.9673751630935, 5871.4715675589405, 6936.445084393337, 7232.674529646073, 7274.27257274279, 7281.963590182015, 5268.972550352721, 6476.870462590722, 6486.416222539994, 6494.837629059217, 6508.0, 3823.617638236154, 3843.655370224161, 3890.3775395936514, 3901.375779875263, 3903.6486716195677, 6945.47908906834, 7035.33164349386, 7507.948887155802, 7518.774436766906, 7523.510971786816, 7344.375728063174, 7394.001809755721, 7396.482246242819, 7401.0, 7407.444441666788, 6341.0, 7489.438292128003, 7494.85010299791, 7499.362554182846, 7507.286807753146, 5752.511036561939, 7173.892391614026, 7187.173475050227, 7200.207977122408, 7200.71197152108, 6746.932530674827, 7066.681999309941, 7069.505134640526, 7075.327843854826, 7085.0, 7427.851442971002, 7482.064741907262, 7496.437767167376, 7499.1750907399055, 7501.612201742695, 4361.629261512807, 4508.1659892919915, 4586.220342541709, 4590.724556526619, 4698.718076915396, 7174.497785154989, 7177.533460325062, 7185.568865868065, 7195.172555156015, 7217.711291548279, 6966.442684585119, 6967.163940327193, 6982.162140543167, 6984.092068031124, 6987.196472405535, 6952.582845029315, 6957.582545047313, 6970.093887794555, 6976.6860491277, 6978.232394436506, 6510.707018184288, 6803.7618683345845, 6819.795406137824, 6839.452843772586, 6844.965775171092, 6919.169699636076, 6956.130483689539, 6959.791206263618, 6963.61700106499, 6981.79054628362, 6172.783952561639, 6826.795196144124, 6839.076724642109, 6841.418479429304, 6848.383645471732], "unit": "score", "name": "prototype.html", "value": 5058.4575820070195}, {"lowerIsBetter": false, "replicates": [687.618371803649, 701.7508784381548, 707.734599525178, 722.5881247688819, 770.4221833624781, 14376.784348234785, 14620.415183392652, 14637.194954277511, 14653.120812751242, 14662.560123196294, 13527.0, 13574.864251357483, 13610.319484025784, 13612.931935340333, 13633.727325453485, 708.1572928215433, 721.7221369772649, 723.5405517496375, 724.5507785173173, 872.136584781067, 720.125048066599, 865.1780808232173, 887.7647423432795, 890.0698769785589, 894.7047474333455, 929.1776777551847, 942.5617088054054, 942.8774259346276, 943.386798580921, 945.5083356654535, 937.0535758883509, 937.1237892570468, 938.8779458670364, 939.8026414453008, 944.0606596436555, 553.4548469757286, 562.4488001758259, 564.4468420947494, 678.8981652752077, 695.214407719279, 14204.076735012191, 14260.429582816674, 14262.286885655676, 14280.357383917748, 14284.000119991604, 12409.0, 12496.437660305308, 12605.810912836314, 12724.0, 12828.871711282862, 8141.307988820958, 9897.604095836157, 10180.074650571785, 10214.28500005, 10670.413127277996, 3410.641882602316, 3565.964340356589, 3590.35373632746, 3631.0740761106013, 3661.9084522886874, 82066.58966705248, 82598.58700706458, 82633.0, 82639.0, 82667.0, 9651.131398174057, 9668.951655241819, 9822.361546499455, 9859.457729824928, 10275.177985761122, 21063.8946805265, 21326.78673213248, 21341.679874801892, 21360.0, 21567.352979410643, 7345.485815992829, 7424.487889239038, 7521.661525231378, 7673.386129109658, 7792.571408572469, 4076.5515793262716, 4107.301758701028, 4119.958800412018, 4143.606357396043, 4151.543330233671, 3532.2582257725653, 3549.982250088733, 3561.8041007744823, 3573.0531409176588, 3577.731670124751, 626.0827887145354, 630.4011189370117, 630.8391360203119, 651.8598501322239, 665.0556210181554, 562.943705629442, 602.3885755957706, 618.2056057965493, 622.4926684751913, 640.8494003909078, 8451.873221901677, 8561.614727337284, 8590.44041243714, 8719.956400218085, 8831.779205519784, 541.228749032627, 546.819549548648, 575.140165452651, 602.8733965867217, 614.4469977020627, 3839.577646458943, 3985.880423587297, 4111.9103437589065, 4227.87316380509, 4348.108637729258, 82625.17374826295, 96670.0, 96802.0, 96904.51547742357, 97097.02902971022, 79447.0, 81337.59331203306, 81452.0, 81699.0, 83104.0, 71773.0, 72225.27774722186, 72474.63762681259, 72816.54366912632, 73110.6344468285, 8622.870656940277, 8712.607932642919, 8979.236764875059, 9010.369274150746, 9024.503652298923, 49664.00671986468, 49895.0, 49974.25038624351, 51259.74370128125, 52443.0, 66152.00771988327, 69935.30064699288, 70257.0, 71956.0, 72224.63887680738, 11357.204995650556, 11357.37534435614, 11598.88401115978, 11807.0, 11995.700107497383, 8716.171963663443, 11290.548378064785, 11905.404729763304, 12028.917397434272, 12375.62873113808, 9155.26757859383, 11663.88336116628, 11792.174547781573, 11943.462544185359, 12039.03687704999, 11503.309801411942, 11806.82289765637, 11875.682059408433, 11895.226810257305, 11895.286282823059, 9357.069736086543, 11344.319340839576, 11377.203595748219, 11527.88472115268, 12429.316387598768, 9260.212881904845, 9576.90423095788, 9639.518024098907, 9755.317127800985, 9896.50517474109, 7426.962865185856, 9369.471164567802, 9979.591938070846, 10032.097111260022, 10139.594416223563], "unit": "score", "name": "yui.html", "value": 6887.622289160893}], "name": "dromaeo_css", "value": 7476.147863721873}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 110.0, 110.0, 112.0, 112.0, 115.0, 108.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [179.0, 124.0, 147.0, 160.0, 120.0, 145.0, 141.0, 119.0, 156.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 187.0, 185.0, 183.0, 184.0, 185.0, 185.0, 181.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 85.0, 82.0, 77.0, 84.0, 86.0, 112.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [97.0, 128.0, 166.0, 109.0, 78.0, 83.0, 116.0, 79.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [85.0, 94.0, 86.0, 91.0, 84.0, 89.0, 84.0, 89.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 85.0, 96.0, 72.0, 127.0, 134.0, 134.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 98.9}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 60.0, 81.0, 80.0, 80.0, 94.0, 50.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 66.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 79.0, 73.0, 69.0, 66.0, 66.0, 69.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 87.0, 82.0, 83.0, 82.0, 81.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 124.0, 132.0, 118.0, 117.0, 124.0, 118.0, 125.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [136.0, 127.0, 140.0, 138.0, 139.0, 128.0, 138.0, 140.0, 139.0, 172.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 69.0, 67.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1450.1000000000001}]} 16:13:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1450.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7476.15"}}} 16:13:07 INFO - Return code: 0 16:13:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:13:07 INFO - # TBPL SUCCESS # 16:13:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:07 INFO - 2016-02-22 16:13:07.192 screenresolution[1982:13819] starting screenresolution argv=screenresolution get 16:13:07 INFO - 2016-02-22 16:13:07.195 screenresolution[1982:13819] Display 0: 1600x1200x32@60 16:13:07 INFO - 2016-02-22 16:13:07.201 screenresolution[1983:13822] starting screenresolution argv=screenresolution list 16:13:07 INFO - Available Modes on Display 0 16:13:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:07 INFO - Intel Iris: 16:13:07 INFO - Chipset Model: Intel Iris 16:13:07 INFO - Type: GPU 16:13:07 INFO - Bus: Built-In 16:13:07 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:07 INFO - Vendor: Intel (0x8086) 16:13:07 INFO - Device ID: 0x0a2e 16:13:07 INFO - Revision ID: 0x0009 16:13:07 INFO - Displays: 16:13:07 INFO - Display: 16:13:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:07 INFO - Display Serial Number: 1600x1200 60 16:13:07 INFO - Main Display: Yes 16:13:07 INFO - Mirror: Off 16:13:07 INFO - Online: Yes 16:13:07 INFO - Rotation: Supported 16:13:07 INFO - Return code: 0 16:13:07 INFO - Running post-action listener: _resource_record_post_action 16:13:07 INFO - Running post-run listener: _resource_record_post_run 16:13:08 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2371584; Write bytes: 706089472; Read time: 34; Write time: 2078 16:13:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 388762112; Write bytes: 382973440; Read time: 28632; Write time: 723 16:13:08 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 2371584; Write bytes: 299809792; Read time: 34; Write time: 1308 16:13:08 INFO - Running post-run listener: _upload_blobber_files 16:13:08 INFO - Blob upload gear active. 16:13:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:08 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 16:13:08 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'] 16:13:08 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 16:13:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:09 INFO - (blobuploader) - INFO - Done attempting. 16:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:10 INFO - (blobuploader) - INFO - Done attempting. 16:13:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:10 INFO - Return code: 0 16:13:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/889753e95341107462d18487eeb495723d644b6f36d8c600251d1421b5939d84d512feaa8a4a244aef5f78a420adefe003945aec5eba21a292c32006efc25695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b66d8b0f5eb8db918a1982a9f8c8800c4799d9e1dcc8cdfd37d94fa28e9199ddd6ee9d319f93c414f3d86fdc40fe521177dc201f92942e3c7726d7e7a3c06bc8"} 16:13:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:10 INFO - Contents: 16:13:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/889753e95341107462d18487eeb495723d644b6f36d8c600251d1421b5939d84d512feaa8a4a244aef5f78a420adefe003945aec5eba21a292c32006efc25695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b66d8b0f5eb8db918a1982a9f8c8800c4799d9e1dcc8cdfd37d94fa28e9199ddd6ee9d319f93c414f3d86fdc40fe521177dc201f92942e3c7726d7e7a3c06bc8"} 16:13:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:10 INFO - Copying logs to upload dir... 16:13:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.694602 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-22 16:13:10.856136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 16:13:10.859928) ========= 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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/889753e95341107462d18487eeb495723d644b6f36d8c600251d1421b5939d84d512feaa8a4a244aef5f78a420adefe003945aec5eba21a292c32006efc25695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b66d8b0f5eb8db918a1982a9f8c8800c4799d9e1dcc8cdfd37d94fa28e9199ddd6ee9d319f93c414f3d86fdc40fe521177dc201f92942e3c7726d7e7a3c06bc8"} build_url:https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/Ft0LqbAVTn-Ldchc3_Pa0w/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/889753e95341107462d18487eeb495723d644b6f36d8c600251d1421b5939d84d512feaa8a4a244aef5f78a420adefe003945aec5eba21a292c32006efc25695", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b66d8b0f5eb8db918a1982a9f8c8800c4799d9e1dcc8cdfd37d94fa28e9199ddd6ee9d319f93c414f3d86fdc40fe521177dc201f92942e3c7726d7e7a3c06bc8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 16:13:10.886887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 16:13:10.887211) ========= 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.Gs4jKzPtBj/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.yfAtPcccOT/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 16:13:10.935196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 16:13:10.935499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 16:13:10.935868) ========= ========= Total master_lag: 0.84 =========