builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0059 starttime: 1458831164.01 results: success (0) buildid: 20160324065825 builduid: 5ce1da0fa0b443af8a323de8ebcc846b revision: 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.007673) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.008120) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.008413) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005256 basedir: '/builds/slave/test' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.180775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.181093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.232994) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.239513) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005869 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.298004) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.298313) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:44.302729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 07:52:44.303017) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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-03-24 07:52:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.85M=0.001s 2016-03-24 07:52:44 (8.85 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111102 ========= master_lag: 1.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 07:52:45.933993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 07:52:45.934353) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.026762 ========= master_lag: 1.85 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 07:52:47.806943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-24 07:52:47.807320) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 --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 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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-03-24 07:52:47,886 truncating revision to first 12 chars 2016-03-24 07:52:47,886 Setting DEBUG logging. 2016-03-24 07:52:47,887 attempt 1/10 2016-03-24 07:52:47,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e4ccb1f574d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 07:52:48,898 unpacking tar archive at: fx-team-9e4ccb1f574d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255767 ========= master_lag: 9.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-24 07:52:58.764188) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:58.770733) ========= echo 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 program finished with exit code 0 elapsedTime=0.005510 script_repo_revision: '9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9' ========= master_lag: 0.30 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 07:52:59.075384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-24 07:52:59.083737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-03-24 07:53:08.743251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-24 07:53:08.743559) ========= /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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:09 INFO - MultiFileLogger online at 20160324 07:53:09 in /builds/slave/test 07:53: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 07:53:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:09 INFO - {'append_to_log': False, 07:53:09 INFO - 'base_work_dir': '/builds/slave/test', 07:53:09 INFO - 'blob_upload_branch': 'Fx-Team', 07:53:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:09 INFO - 'branch': 'Fx-Team', 07:53:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:09 INFO - 'config_files': ('talos/mac_config.py',), 07:53:09 INFO - 'default_actions': ('clobber', 07:53:09 INFO - 'read-buildbot-config', 07:53:09 INFO - 'download-and-extract', 07:53:09 INFO - 'populate-webroot', 07:53:09 INFO - 'create-virtualenv', 07:53:09 INFO - 'install', 07:53:09 INFO - 'run-tests'), 07:53:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:09 INFO - 'download_minidump_stackwalk': True, 07:53:09 INFO - 'download_symbols': 'ondemand', 07:53:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:09 INFO - 'installer_path': 'installer.exe', 07:53:09 INFO - 'log_level': 'info', 07:53:09 INFO - 'log_name': 'talos', 07:53:09 INFO - 'log_to_console': True, 07:53:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:53:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:53:09 INFO - 'opt_config_files': (), 07:53:09 INFO - 'pip_index': False, 07:53:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:09 INFO - 'cmd': ('bash', 07:53:09 INFO - '-c', 07:53:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:09 INFO - 'enabled': True, 07:53:09 INFO - 'halt_on_failure': False, 07:53:09 INFO - 'name': 'check_screen_resolution'},), 07:53:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:09 INFO - 'cmd': ('bash', 07:53:09 INFO - '-c', 07:53:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:09 INFO - 'enabled': True, 07:53:09 INFO - 'halt_on_failure': False, 07:53:09 INFO - 'name': 'check_screen_resolution'},), 07:53:09 INFO - 'run_cmd_checks_enabled': True, 07:53:09 INFO - 'sps_profile': False, 07:53:09 INFO - 'sps_profile_interval': 0, 07:53:09 INFO - 'suite': 'dromaeojs', 07:53:09 INFO - 'system_bits': '32', 07:53:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:09 INFO - 'title': 't-yosemite-r7-0059', 07:53:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:09 INFO - 'use_talos_json': True, 07:53:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:09 INFO - 'work_dir': 'build'} 07:53:09 INFO - ##### 07:53:09 INFO - ##### Running clobber step. 07:53:09 INFO - ##### 07:53:09 INFO - Running pre-action listener: _resource_record_pre_action 07:53:09 INFO - Running main action method: clobber 07:53:09 INFO - rmtree: /builds/slave/test/build 07:53:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:10 INFO - Running post-action listener: _resource_record_post_action 07:53:10 INFO - ##### 07:53:10 INFO - ##### Running read-buildbot-config step. 07:53:10 INFO - ##### 07:53:10 INFO - Running pre-action listener: _resource_record_pre_action 07:53:10 INFO - Running main action method: read_buildbot_config 07:53:10 INFO - Using buildbot properties: 07:53:10 INFO - { 07:53:10 INFO - "project": "", 07:53:10 INFO - "product": "firefox", 07:53:10 INFO - "script_repo_revision": "production", 07:53:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:53:10 INFO - "repository": "", 07:53:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:53:10 INFO - "buildid": "20160324065825", 07:53:10 INFO - "pgo_build": "False", 07:53:10 INFO - "basedir": "/builds/slave/test", 07:53:10 INFO - "buildnumber": 621, 07:53:10 INFO - "slavename": "t-yosemite-r7-0059", 07:53:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:53:10 INFO - "platform": "yosemite_r7", 07:53:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:53:10 INFO - "branch": "fx-team", 07:53:10 INFO - "repo_path": "integration/fx-team", 07:53:10 INFO - "revision": "9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9", 07:53:10 INFO - "stage_platform": "macosx64", 07:53:10 INFO - "builduid": "5ce1da0fa0b443af8a323de8ebcc846b", 07:53:10 INFO - "slavebuilddir": "test" 07:53:10 INFO - } 07:53:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:53:10 INFO - Running post-action listener: _resource_record_post_action 07:53:10 INFO - ##### 07:53:10 INFO - ##### Running download-and-extract step. 07:53:10 INFO - ##### 07:53:10 INFO - Running pre-action listener: _resource_record_pre_action 07:53:10 INFO - Running main action method: download_and_extract 07:53:10 INFO - mkdir: /builds/slave/test/build/tests 07:53: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')]} 07:53:10 INFO - https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:53:11 INFO - Downloaded 1199 bytes. 07:53:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:53:11 INFO - Using the following test package requirements: 07:53:11 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:53:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:53:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:53:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'jsshell-mac.zip'], 07:53:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:53:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:53:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:53:11 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:53:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:53:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:53:11 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:53:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:53: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')]} 07:53:11 INFO - https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:53:13 INFO - Downloaded 17922007 bytes. 07:53:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:53:16 INFO - Return code: 0 07:53:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:53:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:16 INFO - https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:53:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:53:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:53:17 INFO - Downloaded 17922007 bytes. 07:53:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:53:21 INFO - Return code: 0 07:53: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')]} 07:53:21 INFO - https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:53:22 INFO - Downloaded 10847187 bytes. 07:53:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:53:22 INFO - Return code: 0 07:53:22 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')]} 07:53:22 INFO - https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:53:25 INFO - Downloaded 111287915 bytes. 07:53:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:53:25 INFO - mkdir: /builds/slave/test/properties 07:53:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:53:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:53:25 INFO - Contents: 07:53:25 INFO - build_url:https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:53:26 INFO - Running post-action listener: _resource_record_post_action 07:53:26 INFO - Running post-action listener: set_extra_try_arguments 07:53:26 INFO - ##### 07:53:26 INFO - ##### Running populate-webroot step. 07:53:26 INFO - ##### 07:53:26 INFO - Running pre-action listener: _resource_record_pre_action 07:53:26 INFO - Running main action method: populate_webroot 07:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:26 INFO - '--tppagecycles', 07:53:26 INFO - '7'], 07:53:26 INFO - 'tests': ['tsvgm']}}, 07:53:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:53:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:53:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'tests': ['damp', 'tps']}, 07:53:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['damp', 'tps']}, 07:53:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:26 INFO - 'other': {'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'other_l64': {'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:26 INFO - 'ts_paint', 07:53:26 INFO - 'tpaint', 07:53:26 INFO - 'sessionrestore', 07:53:26 INFO - 'sessionrestore_no_auto_restore', 07:53:26 INFO - 'tabpaint']}, 07:53:26 INFO - 'svgr': {'tests': ['tsvgx', 07:53:26 INFO - 'tsvgr_opacity', 07:53:26 INFO - 'tart', 07:53:26 INFO - 'tscrollx', 07:53:26 INFO - 'cart']}, 07:53:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['tsvgx', 07:53:26 INFO - 'tsvgr_opacity', 07:53:26 INFO - 'tart', 07:53:26 INFO - 'tscrollx', 07:53:26 INFO - 'cart']}, 07:53:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'tests': ['tp5o']}, 07:53:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'talos_options': ['--e10s'], 07:53:26 INFO - 'tests': ['tp5o']}, 07:53:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'talos_options': ['--xperf_path', 07:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:26 INFO - 'tests': ['tp5n']}, 07:53:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:26 INFO - 'talos_options': ['--e10s', 07:53:26 INFO - '--xperf_path', 07:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:26 INFO - 'tests': ['tp5n']}}, 07:53:26 INFO - 'talos.zip': {'path': '', 07:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:26 INFO - Running post-action listener: _resource_record_post_action 07:53:26 INFO - ##### 07:53:26 INFO - ##### Running create-virtualenv step. 07:53:26 INFO - ##### 07:53:26 INFO - Running pre-action listener: _resource_record_pre_action 07:53:26 INFO - Running main action method: create_virtualenv 07:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:53: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 07:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:26 INFO - Using real prefix '/tools/python27' 07:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:30 INFO - Installing pip.................done. 07:53:30 INFO - Return code: 0 07:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53: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', 'pip>=1.5'] in /builds/slave/test/build 07:53: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 pip>=1.5 07:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:30 INFO - 'HOME': '/Users/cltbld', 07:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:30 INFO - 'LOGNAME': 'cltbld', 07:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:30 INFO - 'MOZ_NO_REMOTE': '1', 07:53:30 INFO - 'NO_EM_RESTART': '1', 07:53:30 INFO - 'PAGER': '/bin/cat', 07:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:30 INFO - 'PWD': '/builds/slave/test', 07:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:30 INFO - 'SHELL': '/bin/bash', 07:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:30 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:30 INFO - 'USER': 'cltbld', 07:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:30 INFO - 'XPC_FLAGS': '0x0', 07:53:30 INFO - 'XPC_SERVICE_NAME': '0', 07:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53: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 07:53:30 INFO - Cleaning up... 07:53:30 INFO - Return code: 0 07:53:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53: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 07:53: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 07:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:30 INFO - 'HOME': '/Users/cltbld', 07:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:30 INFO - 'LOGNAME': 'cltbld', 07:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:30 INFO - 'MOZ_NO_REMOTE': '1', 07:53:30 INFO - 'NO_EM_RESTART': '1', 07:53:30 INFO - 'PAGER': '/bin/cat', 07:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:30 INFO - 'PWD': '/builds/slave/test', 07:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:30 INFO - 'SHELL': '/bin/bash', 07:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:30 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:30 INFO - 'USER': 'cltbld', 07:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:30 INFO - 'XPC_FLAGS': '0x0', 07:53:30 INFO - 'XPC_SERVICE_NAME': '0', 07:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:31 INFO - Downloading/unpacking psutil>=0.7.1 07:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:33 INFO - Installing collected packages: psutil 07:53:33 INFO - Running setup.py install for psutil 07:53:33 INFO - building 'psutil._psutil_osx' extension 07:53: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 07:53:34 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 07:53:34 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 07:53:34 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 07:53:34 INFO - building 'psutil._psutil_posix' extension 07:53:34 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 07:53:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:53:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:53:34 INFO - ^ 07:53:34 INFO - 1 warning generated. 07:53:34 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 07:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:35 INFO - Successfully installed psutil 07:53:35 INFO - Cleaning up... 07:53:35 INFO - Return code: 0 07:53:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:53:35 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')]} 07:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 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')]} 07:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:35 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:35 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 07:53:35 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 07:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:35 INFO - 'HOME': '/Users/cltbld', 07:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:35 INFO - 'LOGNAME': 'cltbld', 07:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:35 INFO - 'MOZ_NO_REMOTE': '1', 07:53:35 INFO - 'NO_EM_RESTART': '1', 07:53:35 INFO - 'PAGER': '/bin/cat', 07:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:35 INFO - 'PWD': '/builds/slave/test', 07:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:35 INFO - 'SHELL': '/bin/bash', 07:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:35 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:35 INFO - 'USER': 'cltbld', 07:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:35 INFO - 'XPC_FLAGS': '0x0', 07:53:35 INFO - 'XPC_SERVICE_NAME': '0', 07:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:35 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 07:53:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:37 INFO - Installing collected packages: mozsystemmonitor 07:53:37 INFO - Running setup.py install for mozsystemmonitor 07:53:37 INFO - Successfully installed mozsystemmonitor 07:53:37 INFO - Cleaning up... 07:53:38 INFO - Return code: 0 07:53:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53:38 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')]} 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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')]} 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:38 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:38 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 07:53:38 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 07:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:38 INFO - 'HOME': '/Users/cltbld', 07:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:38 INFO - 'LOGNAME': 'cltbld', 07:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:38 INFO - 'MOZ_NO_REMOTE': '1', 07:53:38 INFO - 'NO_EM_RESTART': '1', 07:53:38 INFO - 'PAGER': '/bin/cat', 07:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:38 INFO - 'PWD': '/builds/slave/test', 07:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:38 INFO - 'SHELL': '/bin/bash', 07:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:38 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:38 INFO - 'USER': 'cltbld', 07:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:38 INFO - 'XPC_FLAGS': '0x0', 07:53:38 INFO - 'XPC_SERVICE_NAME': '0', 07:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 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 07:53:41 INFO - Downloading docopt-0.6.1.tar.gz 07:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:41 INFO - Running setup.py install for blobuploader 07:53:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:42 INFO - Running setup.py install for requests 07:53:42 INFO - Running setup.py install for docopt 07:53:42 INFO - Successfully installed blobuploader requests docopt 07:53:42 INFO - Cleaning up... 07:53:42 INFO - Return code: 0 07:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:42 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')]} 07:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:42 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')]} 07:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:42 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:42 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 07:53:42 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 07:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:42 INFO - 'HOME': '/Users/cltbld', 07:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:42 INFO - 'LOGNAME': 'cltbld', 07:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:42 INFO - 'MOZ_NO_REMOTE': '1', 07:53:42 INFO - 'NO_EM_RESTART': '1', 07:53:42 INFO - 'PAGER': '/bin/cat', 07:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:42 INFO - 'PWD': '/builds/slave/test', 07:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:42 INFO - 'SHELL': '/bin/bash', 07:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:42 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:42 INFO - 'USER': 'cltbld', 07:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:42 INFO - 'XPC_FLAGS': '0x0', 07:53:42 INFO - 'XPC_SERVICE_NAME': '0', 07:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-mCrnML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-8l3tZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Tc28_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-CsnQ0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-5r9uVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-FyT_Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-HCXhvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-NzXLcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-l47Y9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:43 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-FwPFnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-nm7cVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-hfBTs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_mKGMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Mix2og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-t6OgLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-xjYx9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:44 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-aoNY6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:44 INFO - Running setup.py install for manifestparser 07:53:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:44 INFO - Running setup.py install for mozcrash 07:53:45 INFO - Running setup.py install for mozdebug 07:53:45 INFO - Running setup.py install for mozdevice 07:53:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Running setup.py install for mozfile 07:53:45 INFO - Running setup.py install for mozhttpd 07:53:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Running setup.py install for mozinfo 07:53:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Running setup.py install for mozInstall 07:53:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:45 INFO - Running setup.py install for mozleak 07:53:46 INFO - Running setup.py install for mozlog 07:53:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Running setup.py install for moznetwork 07:53:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Running setup.py install for mozprocess 07:53:46 INFO - Running setup.py install for mozprofile 07:53:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Running setup.py install for mozrunner 07:53:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:46 INFO - Running setup.py install for mozscreenshot 07:53:47 INFO - Running setup.py install for moztest 07:53:47 INFO - Running setup.py install for mozversion 07:53:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:47 INFO - Cleaning up... 07:53:47 INFO - Return code: 0 07:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:47 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:47 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 07:53:47 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 07:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:47 INFO - 'HOME': '/Users/cltbld', 07:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:47 INFO - 'LOGNAME': 'cltbld', 07:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:47 INFO - 'MOZ_NO_REMOTE': '1', 07:53:47 INFO - 'NO_EM_RESTART': '1', 07:53:47 INFO - 'PAGER': '/bin/cat', 07:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:47 INFO - 'PWD': '/builds/slave/test', 07:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:47 INFO - 'SHELL': '/bin/bash', 07:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:47 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:47 INFO - 'USER': 'cltbld', 07:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:47 INFO - 'XPC_FLAGS': '0x0', 07:53:47 INFO - 'XPC_SERVICE_NAME': '0', 07:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:47 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_NWExR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:47 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)) 07:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:47 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-DrikBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:47 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-YoiSkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:47 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)) 07:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:47 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-KiIvf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Yy7Pnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-hZxBn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-bNQScL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-QrbsW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-WO2EpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-FGHu1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-G3Hi9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-xIVryT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:48 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)) 07:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:48 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-zTRaFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:49 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)) 07:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-LmMF1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:49 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)) 07:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-oCLU9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:49 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)) 07:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-bS6VNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:49 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)) 07:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:49 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-chlKP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:49 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)) 07:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:49 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)) 07:53:49 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)) 07:53:49 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)) 07:53:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:49 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 07:53:49 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 07:53:49 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 07:53:49 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 07:53:49 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 07:53:49 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 07:53:51 INFO - Downloading blessings-1.6.tar.gz 07:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:51 INFO - Installing collected packages: blessings 07:53:51 INFO - Running setup.py install for blessings 07:53:52 INFO - Successfully installed blessings 07:53:52 INFO - Cleaning up... 07:53:52 INFO - Return code: 0 07:53:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:52 INFO - Reading from file tmpfile_stdout 07:53:52 INFO - Current package versions: 07:53:52 INFO - blessings == 1.6 07:53:52 INFO - blobuploader == 1.2.4 07:53:52 INFO - docopt == 0.6.1 07:53:52 INFO - manifestparser == 1.1 07:53:52 INFO - mozInstall == 1.12 07:53:52 INFO - mozcrash == 0.17 07:53:52 INFO - mozdebug == 0.1 07:53:52 INFO - mozdevice == 0.48 07:53:52 INFO - mozfile == 1.2 07:53:52 INFO - mozhttpd == 0.7 07:53:52 INFO - mozinfo == 0.9 07:53:52 INFO - mozleak == 0.1 07:53:52 INFO - mozlog == 3.1 07:53:52 INFO - moznetwork == 0.27 07:53:52 INFO - mozprocess == 0.22 07:53:52 INFO - mozprofile == 0.28 07:53:52 INFO - mozrunner == 6.11 07:53:52 INFO - mozscreenshot == 0.1 07:53:52 INFO - mozsystemmonitor == 0.0 07:53:52 INFO - moztest == 0.7 07:53:52 INFO - mozversion == 1.4 07:53:52 INFO - psutil == 3.1.1 07:53:52 INFO - requests == 1.2.3 07:53:52 INFO - wsgiref == 0.1.2 07:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:52 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')]} 07:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:52 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')]} 07:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:52 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:52 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 07:53:52 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 07:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:52 INFO - 'HOME': '/Users/cltbld', 07:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:52 INFO - 'LOGNAME': 'cltbld', 07:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:52 INFO - 'MOZ_NO_REMOTE': '1', 07:53:52 INFO - 'NO_EM_RESTART': '1', 07:53:52 INFO - 'PAGER': '/bin/cat', 07:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:52 INFO - 'PWD': '/builds/slave/test', 07:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:52 INFO - 'SHELL': '/bin/bash', 07:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:52 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:52 INFO - 'USER': 'cltbld', 07:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:52 INFO - 'XPC_FLAGS': '0x0', 07:53:52 INFO - 'XPC_SERVICE_NAME': '0', 07:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 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)) 07:53:52 INFO - Cleaning up... 07:53:52 INFO - Return code: 0 07:53:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:52 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')]} 07:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:52 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')]} 07:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:52 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:52 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 07:53:52 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 07:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:52 INFO - 'HOME': '/Users/cltbld', 07:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:52 INFO - 'LOGNAME': 'cltbld', 07:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:52 INFO - 'MOZ_NO_REMOTE': '1', 07:53:52 INFO - 'NO_EM_RESTART': '1', 07:53:52 INFO - 'PAGER': '/bin/cat', 07:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:52 INFO - 'PWD': '/builds/slave/test', 07:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:52 INFO - 'SHELL': '/bin/bash', 07:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:52 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:52 INFO - 'USER': 'cltbld', 07:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:52 INFO - 'XPC_FLAGS': '0x0', 07:53:52 INFO - 'XPC_SERVICE_NAME': '0', 07:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:52 INFO - Downloading/unpacking jsonschema 07:53:52 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 07:53:52 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 07:53:52 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 07:53:52 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 07:53:52 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 07:53:52 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 07:53:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:55 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 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 07:53:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:55 INFO - warning: no files found matching '*.txt' 07:53:55 INFO - no previously-included directories found matching 'build' 07:53:55 INFO - no previously-included directories found matching 'dist' 07:53:55 INFO - no previously-included directories found matching '.git*' 07:53:55 INFO - Installing collected packages: jsonschema, functools32 07:53:55 INFO - Running setup.py install for functools32 07:53:56 INFO - warning: no files found matching '*.txt' 07:53:56 INFO - no previously-included directories found matching 'build' 07:53:56 INFO - no previously-included directories found matching 'dist' 07:53:56 INFO - no previously-included directories found matching '.git*' 07:53:56 INFO - Successfully installed jsonschema functools32 07:53:56 INFO - Cleaning up... 07:53:56 INFO - Return code: 0 07:53:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:53:56 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')]} 07:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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')]} 07:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:56 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 0x108649a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108659420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb5a58c490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, '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.mlHwuX7zhY/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.u9ILnV82YG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 07:53:56 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 07:53:56 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 07:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:53:56 INFO - 'HOME': '/Users/cltbld', 07:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:53:56 INFO - 'LOGNAME': 'cltbld', 07:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:56 INFO - 'MOZ_NO_REMOTE': '1', 07:53:56 INFO - 'NO_EM_RESTART': '1', 07:53:56 INFO - 'PAGER': '/bin/cat', 07:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:56 INFO - 'PWD': '/builds/slave/test', 07:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:53:56 INFO - 'SHELL': '/bin/bash', 07:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:53:56 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:53:56 INFO - 'USER': 'cltbld', 07:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:56 INFO - 'XPC_FLAGS': '0x0', 07:53:56 INFO - 'XPC_SERVICE_NAME': '0', 07:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:56 INFO - Downloading/unpacking flake8 07:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:58 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 07:53:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:53:59 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 07:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:00 INFO - no previously-included directories found matching 'docs/_build' 07:54:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:54:00 INFO - Running setup.py install for pep8 07:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:54:00 INFO - no previously-included directories found matching 'docs/_build' 07:54:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:54:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:54:00 INFO - Cleaning up... 07:54:00 INFO - Return code: 0 07:54:00 INFO - Running post-action listener: _resource_record_post_action 07:54:00 INFO - Running post-action listener: _start_resource_monitoring 07:54:00 INFO - Starting resource monitoring. 07:54:00 INFO - ##### 07:54:00 INFO - ##### Running install step. 07:54:00 INFO - ##### 07:54:00 INFO - Running pre-action listener: _resource_record_pre_action 07:54:00 INFO - Running main action method: install 07:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:00 INFO - Reading from file tmpfile_stdout 07:54:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:00 INFO - Reading from file tmpfile_stdout 07:54:00 INFO - Output received: 07:54:00 INFO - Usage: mozinstall [options] installer 07:54:00 INFO - Options: 07:54:00 INFO - -h, --help show this help message and exit 07:54:00 INFO - -d DEST, --destination=DEST 07:54:00 INFO - Directory to install application into. [default: 07:54:00 INFO - "/builds/slave/test"] 07:54:00 INFO - --app=APP Application being installed. [default: firefox] 07:54:00 INFO - mkdir: /builds/slave/test/build/application 07:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:54:34 INFO - Reading from file tmpfile_stdout 07:54:34 INFO - Output received: 07:54:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:54:34 INFO - Running post-action listener: _resource_record_post_action 07:54:34 INFO - ##### 07:54:34 INFO - ##### Running run-tests step. 07:54:34 INFO - ##### 07:54:34 INFO - Running pre-action listener: _resource_record_pre_action 07:54:34 INFO - Running main action method: run_tests 07:54:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:34 INFO - 2016-03-24 07:54:34.316 screenresolution[1648:7689] starting screenresolution argv=screenresolution get 07:54:34 INFO - 2016-03-24 07:54:34.319 screenresolution[1648:7689] Display 0: 1600x1200x32@60 07:54:34 INFO - 2016-03-24 07:54:34.325 screenresolution[1649:7691] starting screenresolution argv=screenresolution list 07:54:34 INFO - Available Modes on Display 0 07:54:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:34 INFO - Intel Iris: 07:54:34 INFO - Chipset Model: Intel Iris 07:54:34 INFO - Type: GPU 07:54:34 INFO - Bus: Built-In 07:54:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:34 INFO - Vendor: Intel (0x8086) 07:54:34 INFO - Device ID: 0x0a2e 07:54:34 INFO - Revision ID: 0x0009 07:54:34 INFO - Displays: 07:54:34 INFO - Display: 07:54:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:34 INFO - Display Serial Number: 1600x1200 60 07:54:34 INFO - Main Display: Yes 07:54:34 INFO - Mirror: Off 07:54:34 INFO - Online: Yes 07:54:34 INFO - Rotation: Supported 07:54:34 INFO - Return code: 0 07:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:54:34 INFO - Python 2.7.3 07:54:34 INFO - Return code: 0 07:54:34 INFO - grabbing minidump binary from tooltool 07:54:34 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')]} 07:54:34 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 0x1084e8e00>, '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 0x108311db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:54:34 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 07:54:34 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 07:54:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:54:34 INFO - Return code: 0 07:54:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:54:35 INFO - Return code: 0 07:54:35 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/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 07:54:35 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/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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 07:54:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mlHwuX7zhY/Render', 07:54:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:35 INFO - 'HOME': '/Users/cltbld', 07:54:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:35 INFO - 'LOGNAME': 'cltbld', 07:54:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:54:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:35 INFO - 'MOZ_NO_REMOTE': '1', 07:54:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:54:35 INFO - 'NO_EM_RESTART': '1', 07:54:35 INFO - 'PAGER': '/bin/cat', 07:54:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:35 INFO - 'PWD': '/builds/slave/test', 07:54:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:54:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:35 INFO - 'SHELL': '/bin/bash', 07:54:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u9ILnV82YG/Listeners', 07:54:35 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:54:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:35 INFO - 'USER': 'cltbld', 07:54:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:35 INFO - 'XPC_FLAGS': '0x0', 07:54:35 INFO - 'XPC_SERVICE_NAME': '0', 07:54:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:35 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/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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 07:54:36 INFO - mozversion application_buildid: 20160324065825 07:54:36 INFO - mozversion application_changeset: 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 07:54:36 INFO - mozversion application_display_name: Nightly 07:54:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:54:36 INFO - mozversion application_name: Firefox 07:54:36 INFO - mozversion application_remotingname: firefox 07:54:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:54:36 INFO - mozversion application_vendor: Mozilla 07:54:36 INFO - mozversion application_version: 48.0a1 07:54:36 INFO - mozversion platform_buildid: 20160324065825 07:54:36 INFO - mozversion platform_changeset: 9e4ccb1f574d3190e0ae6d69c01f30b973e1ece9 07:54:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:54:36 INFO - mozversion platform_version: 48.0a1 07:54:36 INFO - using testdate: 1458831276 07:54:36 INFO - actual date: 1458831276 07:54:36 INFO - starting webserver on 'localhost:49273' 07:54:36 INFO - SUITE-START | Running 2 tests 07:54:36 INFO - TEST-START | dromaeo_css 07:54:36 INFO - operating with platform_type : mac_ 07:54:36 INFO - Initialising browser for dromaeo_css test... 07:54:36 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpf3O9Ij/profile http://localhost:49273/getInfo.html) 07:54:38 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 07:54:38 INFO - PROCESS | 1667 | colorDepth:24 07:54:38 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 07:54:38 INFO - PROCESS | 1667 | __metrics 07:54:38 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:54:38 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:54:39 INFO - TEST-INFO | 1667: exit 0 07:54:39 INFO - Browser initialized. 07:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:54:39 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpf3O9Ij/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:51 INFO - PROCESS | 1670 | RSS: Main: 247296000 07:54:51 INFO - PROCESS | 1670 | 07:55:43 INFO - PROCESS | 1670 | 1458831343017 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] 07:57:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 07:57:53 INFO - PROCESS | 1670 | RSS: Main: 377753600 07:57:53 INFO - PROCESS | 1670 | 08:00:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 08:00:56 INFO - PROCESS | 1670 | RSS: Main: 374013952 08:00:56 INFO - PROCESS | 1670 | 08:03:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 08:03:59 INFO - PROCESS | 1670 | RSS: Main: 369238016 08:03:59 INFO - PROCESS | 1670 | 08:07:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 08:07:02 INFO - PROCESS | 1670 | RSS: Main: 332734464 08:07:02 INFO - PROCESS | 1670 | 08:10:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 08:10:05 INFO - PROCESS | 1670 | RSS: Main: 335937536 08:10:05 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 08:13:08 INFO - PROCESS | 1670 | RSS: Main: 387051520 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | __start_tp_report 08:13:08 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 08:13:08 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 08:13:08 INFO - PROCESS | 1670 | |i|pagename|runs| 08:13:08 INFO - PROCESS | 1670 | |0;dojo.html;3223.629282632497;3402.8128452935093;3506.999999999998;3551.9822400887992;3582.4089025310823;5643.830685079444;5724.6851423171765;5724.799632012875;5729.6848673323;5732.054211055181;5081.136206844836;5442.809501667432;5716.3426205986325;5864.149698293745;5903.409659034094;5171.043356978971;5207.062728708831;5235.607329450288;5240.213967904807;5334.759935802898;5313;5341.1988201769655;5353.544948679348;5395.001924643953;5416.864578385533;5136;5245.475452454724;5247.2653828464045;5266.973665131688;5290.074237008527;5191;5214.5046220609365;5252.080885845;5283.154695248781;5288.048151332759;5245.947540524584;5258.1061219592375;5259.3951695555115;5270.2358158067245;5294.364676238876;5616.859578510529;5628.352739434977;5632.971835140839;5642.238297829782;5645.520130788888;6043.111230148123;6117.583823141527;6246.781362652331;6256.468200202989;6271.435570798604;6222.906656400158;6227.750889964396;6277.309495955487;6314.936850631527;6315.336889626615;5825.446582574648;5827.854303642401;5830.562707796932;5832.037713777179;5842.152887831283;5314.97342513285;6179.351168127372;6207.410296021871;6273.592216506004;6283.465905398001;6158.3841615838055;6170.5372097092;6178;6179.5056395488255;6186.350433204539;6270.561060725706;6290.779822706183;6293.842653933688;6294.716737746812;6296.748130074746;6043.09353596964;6095.468565591287;6119.8984182846625;6206.906896396557;6238.251409830849;6123.8162855114415;6129.014559402219;6147.170132032208;6197.25632924052;6206.038064100072;4877.5366340197625;4909.828156014522;4910.312556242129;4923.359963204832;4928.888292772589;4362.541933097043;4393.582609652078;4415.602595766396;4422.668299877458;4440.911181776346;5548.4174161712435;5646.237757902631;5661.065924122556;5682.488576028178;5747.39652336507;6141.477974372228;6158.922188616974;6163.075538669146;6205.317415084337;6293.716782744787;5705.22979397776;5709.029464990961;5716.256886604715;5750.25246717924;5753.108268218432;5309;5350.91973620396;5354.839354819362;5362.115250983622;5369.543588794996;6172.22847144107;6205.968970155211;6241.063840423973;6280.497560195265;6290.056491526308;6276.497880169667;6293.937060629335;6294.339094395205;6300.621962682254;6316.842078948063;6230.968845155745;6257.687115644108;6265.96867015662;6267.2165979252595;6281.434670879643;6028.457438830526;6125.571219981412;6131.774283661862;6214.875702486015;6223;4673.252279635242;5912;6202.069689546604;6277.12120303167;6295.338989406229;5950.31571369298;6088.4215999479975;6092.75628974836;6112.449879510866;6119.296280927572;6042.909356359746;6110.984061328701;6118.724657390339;6118.9846826261555;6134.589663226307;5923.733431995657;5944.138099975393;5950.761969521171;5951.345352011189;5976.402359763989;5923;6062.90905636407;6115.327313995368;6130.356312587114;6132.8773424532155;5954.166416701752;5963.403659634002;6001.3698561652145;6019.247594050744;6044.063170208625 08:13:08 INFO - PROCESS | 1670 | |1;ext.html;496.45142117959676;536.3617295418452;585.7510558012846;646.8738595973786;650.2749434380665;33708.831455842716;39212.80393598035;39250;39425;39528.01179970499;41688.791556042175;42204.788976055155;42232.57767422325;42263;42403;8350.206730360605;8357.289630381425;9432.81134377312;9671.274654400913;9671.806563868719;9549.188318992894;9687.660931867385;9723.46520941348;9812.411255324667;9814.312998090101;9754.658586949457;9842.163416109639;9845.212383009379;9849.458279794608;9875.1112399884;9766.755831104208;9810.166135878459;9820.116189542976;9820.754481138028;9829.705108846745;9612.615495380176;9742.561584728634;9747.756306092333;9766.462844543546;9769.120779129842;41156.588434115576;41326.58673413257;41476;41568.792156039024;41576.79211603923;3144.213946513372;3195.680431956809;3282.3271229397915;3427.5715535558056;3702.8518859245596;29579.556306655417;30792.69207307943;31421.84289078563;31443.52834707481;31500.842495787605;2752.160591019738;2771.6673999120035;2845.271072417899;2900.419916016805;2902.4630443368046;386842;391937.04031479947;392759;393546;393750;68744;70496.64751676311;70613.94079088818;75806.62096689592;75872;77455.22544774594;79307;79531;79602.60198699085;79681;17054.488365349058;17246.568835778955;17275.049872257146;17321.480355589352;17329.91335043342;12917.870821291855;12985.415656295301;13003.414846331749;13020.544280950122;13023.088383813041;22083.227087051877;23398.76601234;23418.882905585702;23504.882475587514;23531.52936941286;10036.749081272881;10202.438865862301;10342.586296548205;10345.327553708985;10373.688789336333;1023.2581378500528;1079.551985925832;1112.360392774158;1141.178351586856;1145.0782120393164;24298.635520467207;28772;28919.56620650692;29447.411051778843;29581.85209073941;1105.1932089574655;1130.6721050895312;1177.9823302650468;1194.814803705427;1226.9447874845653;14343.354549045318;14606.415743370359;14632.268386580628;14657.780133298009;14938.775918361232;519625;527015;528876;532063;534117;59472.40527594669;59789.103163452586;59957.40042599606;60201.69899150564;60239.39760602426;1343.7648411527944;1435.2464955898238;1491.7986071880591;1496.5285934930462;1630.6657135287237;25884.22347329583;26454.735452645225;29146.56280155757;29524.261893452836;29897.850510748176;46379.30431043605;47424.28863567118;47963.520364795906;48107.75946120247;48201.517984821105;372215;375423;375651;375977;376953;28286;32547.51178732368;33808.830955846046;34165.829170853984;34229.828850855585;42356.788216058725;43630;43686.56313436825;44100;45068.54931450643;32483;34273.65726342705;36020.27959440849;36119.45820812637;36849.81575092107;29576.852115739282;35280.64719352876;35605.82197088998;35688;35930.64069359273;29685;35216.29567408689;35667.46498802468;36460.63539364572;36551.45172822463;28422.147335579964;31306;31793;31859.68140318567;32198.35603287968;19931.302404416358;23209.767902321437;23926;24264.757352426248;24497.51004979926 08:13:08 INFO - PROCESS | 1670 | |2;jquery.html;337.88005258133364;361.2792479004387;366.5216891955998;370.1671239710651;370.8442454169249;19620.90189549052;20234.29179978701;20397.184112635514;20825.895870520628;20865.37403877886;19498.707519387186;20333.389998300074;20415.183392664276;20542.89728551355;20583.382498525032;5643.548516118711;5800.47795698387;5803.564732645047;5847.122931560279;5873.559483038768;4142.689298302625;4254.298040823261;4444.377787109807;5680.318361796591;6288.8742225155465;6242.843928901769;6251.468625166866;6256.998880179172;6258.499320054385;6264.279607845087;5567.944320556783;5825.592208545403;5828.475437210672;6209.410106039919;6260.593061451013;3745.681617062553;3923.9607603923882;5337.492938170868;5584.329880414336;5585.553155747531;12826.679333016657;13001.479940802357;13018.86981130186;18926.43220703381;25752.74247257541;1940.534271774764;2109.9683504747286;2194.1771835561663;2257.932262032142;2768.9446211075865;9684.46735429558;9782.217422606245;9900.80198396028;9950.751231219278;10033.598656053822;1706.3771723321022;1712.2808420463434;1739.6955532781712;1767.7790276215474;1945.8832470051843;72633.63683181602;100029;107307;107542;109378.45310773475;11034.558617655204;11219.66341009771;11233.32600044;11267.605633802777;11535.884641153649;13697.657558561115;13727.588172354845;13749.243791591358;13785.862141378459;13788.379522921492;7656.966309548251;7936.563489008045;8303.252707256375;8471.322294216448;8568.400211985227;8533.146685331541;8567.957160214284;8590.055093939662;8664.566771661392;8714.956425217833;4411.955880441219;4494.280915053641;4501.41481607389;4546.795394207269;4560.224761790503;1601.5355546891503;1835.7888842782984;1905.6188762247607;1916.4633902507042;1941.5437372217518;915.5330781301584;927.452802846324;950.9144177024101;1001.3841487485145;1055.4933631856752;18963.43109706711;20229.696554551694;20603.79396206049;20806.375808725763;20861.269855554983;904.3307952115388;909.3589019741066;941.8257622339752;963.2307117038514;971.868797712314;9061.365704400629;9291;10394.792104158027;10743.731406714895;11067.50196241171;579079;583128;629813;632253;632359;104140;104260.43609345866;108072;108385.0978087069;110935;1061.4207475833798;1076.5586109695143;1096.528492748126;1096.8299913513258;1098.1434481104752;15181.924090379478;18010.819891800915;19002.334918277793;19021.809781902557;19284.614307713488;48574;51272.74363628158;51899.96200075902;52579.896804127406;52927.470725293795;68559;68906.65546672234;69284.96072558814;69400.30599693938;69548;7672.424568157299;7765.107012693613;7847.725329613436;7975.5613441261285;8158.673653053811;7566.886496702444;11542.307461552333;11635.47640356169;11658.76682466363;12501.74996500083;10726.195535334726;10774.353538787698;10881.401522916316;10979.066779323846;11109.944450277697;7674.462787605037;10570.524326405177;10659;10850.45747712627;10878.40168790724;9278.814423711354;10195.592176312864;10589.417582032755;11383.829242561202;11409.60066397672;7406.4074874008875;7654;7707;7727.768166955;8121.715739949073;10451.16390688728;10650.89349106499;10874.891251087703;10902.50938707776;10932.56269749201 08:13:08 INFO - PROCESS | 1670 | |3;mootools.html;1380.4271227440609;1462.9707405851889;1655.0400767554816;1896.5448292409817;2068.400163952453;7837.686492540299;8645.26515246204;8814.823703525926;8818.250448711868;8858.424202426853;8450.323974082074;8638.438501497414;8644.092370301121;8682.956585217082;8696.434731742433;2446.9510609787794;2473.1714875516723;2475.7400472950353;2478.8884500197532;2486.676732024834;2422.1280339077916;2488.30327508298;2489.427431690712;2491.750824917512;2503.5493611149986;2466.075221791828;2486.627005949113;2503.4993001399703;2510.3222130024883;2510.5104504621604;2455.852648841066;2477.702675678921;2487.2911220302217;2488.427661637815;2495.563276426636;2442.5237078769646;2468.25952214335;2477.764612361823;2483.1060818105466;2493.875306234699;8800.427972181787;8837.734867953972;8842.646294148291;8854.335924805666;8891.911080889173;4537.727736335797;5521.365043020064;5525.696086715229;5568.136938774496;5589.692566908819;3570.1431656402538;3637.1634524059614;3681.226942342111;3707.4068149096283;3708.629137086297;1022.964196253135;1033.736397218712;1035.8705161854768;1038.693585392311;1047.0890325416935;11725.824112638316;11760.588379406765;11799.351035693033;11803.350815705218;11812.468438920268;4837.69382266786;4852.126617208936;4857.077155340474;4908.631852611068;4974.403071631427;8979.371443998858;9969.052939970692;10148.898511014942;10165.186785057178;10171.033751793568;5375.81184658535;5458.863528411742;5525.281713377235;5537.335519737658;5545.306836645419;4376.299792033323;4498.977505112453;4773.737444440589;4933.703977761345;5026.824061157842;3892.4550562921213;3976.6421022108148;3979.5622481527007;3987.4616926715103;4037.7375470594316;1316.230005446805;1317.5783749200355;1323.589687196972;1325.6288239293012;1337.8595247498872;973.124188230584;977.2524019125375;992.3153024413276;1079.63292480557;1093.6664317383115;7987.760367188994;8122.065962414398;8124.878126828103;8145.714899978472;8163.346932245406;1089.455272363818;1166.6383421139474;1204.6687161030786;1212.4119801896074;1241.0381953985734;6278.780242691484;6317.305096439388;6318.083877837687;6318.178636777189;6334.144890439732;8457.746267611981;10194.031567001122;10425.843612345821;10428.634997775041;10533.157347412189;10305.103541141694;10327.380357178594;10424.583016679248;10425.739356516147;10428.374297542172;8161.306288965386;8350.498970061693;8356.122607126164;8364.874526882102;8373.288270497076;8058;8154.38842086834;8251.33989280868;8306.293965013041;8332.291755200877;9286.489243091695;9643.807123857343;9671.371360861522;9688.176504997155;9742.123208911233;9489.620415183315;9754.75613109678;9791.971842956673;9931.354461959949;9956.054174853378;6803.659817009031;6982.895256571054;7324.450666199949;7562.470627056054;7686.231376862493;8267.462614930011;8299.253067223979;8335.999680038434;8343.207395297437;8352.29005534512;7051.471139664648;7308.30571095745;7312;7441.293077157661;7484.401247900264;7098.325659062587;7244.746433874789;7298.525595836254;7303.634818259172;7372.520786148883;7661.233876612294;7737.14891361961;7753.728619498291;7767.4562780607075;7769.417293703108;6976.4767642426;6982.1272340957385;7068.787936361918;7090.964545177241;7093.82265443368;7118.679659415235;7156.642167891689;7157;7172.497925145399;7190.137183538009 08:13:08 INFO - PROCESS | 1670 | |4;prototype.html;320.87004763070956;329.18526646549793;331.9983400082999;334.5801019720251;340.65083289628143;6603.075569420279;6604.537682362236;6613.669316534172;6619.702113404896;6702.664866756667;6503.609783412999;6549.214094308678;6560.278369379364;6566.1464009678675;6568.080468734369;4638.675292729494;4738.47876733559;4755.191617425029;4903.289023091658;4932.309476673268;4855.960496591422;4863.319135321058;4876.097921884445;4883.755812209393;4884.609231261508;4802.351682522867;4808.687435316693;4810.97594512027;4827.686200396981;4850.5877000455;4629.699069560468;4723.881902952437;4819.831305904277;4819.951800481986;4848.369711937426;4122.2579935611575;4144.48193975753;4146.4402305688645;4149.481314835645;4156.896077598054;5069.695818250917;6250.1874756281395;6270.905936410957;6275.2783429905685;6293.527985401068;5646.661200327993;5657.20799088128;5661.065924122515;5670.5463562914865;5672.829815105553;5818.3308919474375;6743.831404214934;6880.208775990775;6902.516823822334;6925.549839260432;4495.662825288084;4649.744264065475;4660.254359302496;4699.483056863743;4700.412448443944;7141.357277845019;7334.376577990877;7345.963270183614;7352.595607241599;7374.594397308199;4778.450478194983;4779.283107533828;4780.067886762048;4782.784774685148;4783.95216047842;4832.081904438145;4837.95162048375;4842.280990248481;4845.1520983828395;4850.75746212688;4657.254839225708;5679.914801277984;5684.488396044376;5692.857678557986;5695.231143795618;5724.398938111438;6659.533832631766;6976.790696279119;6992.056072430259;6993.615351155735;1669.0986867091876;1673.9246733897003;1684.6125391159858;1686.9156542173089;1688.0715606416422;1039.5861628185662;1045.3048722599538;1106.303029091667;1111.3942901118749;1134.6709454258173;6375.438017685697;6442;6445.838854028687;6456.903146452807;6481.319461456574;5937.970310148422;7211.314925082109;7250.492465527468;7256.34692877633;7271.89092163618;6223.813285601439;6489.026646003137;6634.568753031038;6638.601683898982;6640.601563906181;3808.3906574947873;3852.287326844487;3854.995402390741;3855.055511399669;3855.614438556122;7303.89044164338;7620.771376858703;7626.36890272855;7653.732119375906;7669.923300767033;7451.105867295959;7509.098908131059;7515.173330933593;7517.097948246136;7537.736179233701;7615.048118985127;7618.885716714143;7624.847503049908;7632.427567932427;7637.236276372319;7020.22777494465;7185.820354491179;7249.420046396381;7256.1655409628565;7293.015442915139;7127.643617819192;7159.355657990805;7168.354848063699;7186.532875363085;7186.568805871664;7597.354224890946;7607.961960190164;7611.961940190264;7618.276263754934;7632.045994250719;4569.063342014812;4627.88430289232;4637.628989680885;4638.814447422065;4639.628829693684;6951.004862720237;7258.02016727735;7259.745908893164;7275.527090739297;7282.198958114497;6968.407685346802;7033.402160816388;7033.648317584202;7039.612821294878;7045.894311585433;6948.062011628365;6986;6986.126734158231;6998.720051197895;7002.544834585736;5602.635828671123;6757.966210169115;6804.965975170093;6808.38724514796;6808.795736127924;5818.709064546841;6736.730530778714;6946.6179360135675;6950.687219075053;6952.443804495527;6586.242582103119;6770.526063175727;6777.661116944231;6790.558613690095;6853.554518956252 08:13:08 INFO - PROCESS | 1670 | |5;yui.html;704.3027402871156;745.3105877063718;768.2471178245316;780.2977320411629;827.2596026556232;14952.327145278461;15040.473583424582;15289.617759556017;15314.157721325322;15314.310856011492;14355.425782968694;14413.351399187035;14458.855411445882;14460.421583136662;14465.638359041002;746.6304179431189;757.1444267977178;895.3821862914584;917.3578495053456;929.665320484625;919.9034101419355;921.3596550397476;922.2898368256439;923.5613083785215;925.1997022575457;977.8191034658611;979.1677074486665;979.4417182206146;979.5151400056982;981.082687687015;775.2828633514005;954.8472244440926;968.6900191938582;970.3062310447993;972.2076507646245;731.0715391452878;731.8024133483983;732.4726197138052;733;735.6542425060213;15247.542573722805;15341.156236406992;15364.542977830011;15376.000559963566;15384;12599;12604.936975315157;12642.178258413174;12777.808332875014;12938.805917911239;9903.504824758733;9975.850362244571;10045;10100.191984641211;10395.16838652906;3492.2840817632577;3525.841337139809;3532.8056956867363;3560.6439356064448;3617;75533.48933021363;76741.61629191875;76975.23024769737;77842.05394865117;80185.19814801894;9263.814723705487;9437.386569872937;9444.150026497648;9660.613575456902;9733.318667693335;20859.478513036993;21321.78678213229;21350.14599416037;21358.466038349165;21390.358289251348;7434.1450733166375;7567.9243207568325;7580.469367144247;7596.2023987481625;7696.499727517694;4124.463819703419;4130.56629053945;4199.517055538652;4200.222958752641;4230.746155230696;3606.6753992140834;3646.1796095878217;3651.4157734762844;3652.7625704329134;3653.1415117447377;618.3322012226874;661.507177153024;677.4681874728315;677.9796606101825;680.4216416046321;496.5258178439654;503.85388237411473;528.5401700520572;587.0607028754044;614.0328981853598;7928.5639289838455;8004.759857204293;8074.434789564674;8128.252843594826;8155.592220388957;573.5784198614016;591.9940800592025;601.4166258729026;607.3198018219622;625.5652321636419;3319.3195394943978;3601.4777857210556;3761.247750449921;3818.293615681108;3820.121372084436;87357.56321218354;87685.56157219173;88253.23493530221;91990;92240.07759922315;74136.88794668084;75648;75951.62024189843;76581;76773;67029.66485167641;68208.6589567059;68569.62860742757;68684;69116.6544167276;8397.454165479225;8398.706045288385;8408.201220884006;8539.274161696325;8631.050584435832;47930;49187;49687;50011.49988500068;50799.746001269756;60625.69687151536;65001.67499162474;65576.6721166391;68658.65670671615;71682.28317716756;11081.83377249358;11099.445027748741;11110.500027498943;11152.776944460904;11303.321800691985;11709.473073711533;11846.940765296118;11942.34317112567;12191;12638.052146088896;11287.943560282147;11296;11450;11478.82781758291;11699.941500292785;10837.403942782907;10885.455727213766;11054.336739795637;11122.61070862516;11232.66302010941;10665;10777.353358798497;11035.613753518588;11057.004869561779;12086.39568021613;9360.485173315534;9426.293028022788;9462.479563624067;9468.763280918032;9839.458829764146;9323.580438880132;9428.717138485856;9578.13796758295;9589.760255993657;9667.081627245401 08:13:08 INFO - PROCESS | 1670 | __end_tp_report 08:13:08 INFO - PROCESS | 1670 | __start_cc_report 08:13:08 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1188 08:13:08 INFO - PROCESS | 1670 | __end_cc_report 08:13:08 INFO - PROCESS | 1670 | __startTimestamp1458832388938__endTimestamp 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | ------- Summary: start ------- 08:13:08 INFO - PROCESS | 1670 | Number of tests: 6 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5730.54 Median:5950.76 stddev:624.08 (10.5%) stddev-sans-first:594.20 08:13:08 INFO - PROCESS | 1670 | Values: 3223.6 3402.8 3507.0 3552.0 3582.4 5643.8 5724.7 5724.8 5729.7 5732.1 5081.1 5442.8 5716.3 5864.1 5903.4 5171.0 5207.1 5235.6 5240.2 5334.8 5313.0 5341.2 5353.5 5395.0 5416.9 5136.0 5245.5 5247.3 5267.0 5290.1 5191.0 5214.5 5252.1 5283.2 5288.0 5245.9 5258.1 5259.4 5270.2 5294.4 5616.9 5628.4 5633.0 5642.2 5645.5 6043.1 6117.6 6246.8 6256.5 6271.4 6222.9 6227.8 6277.3 6314.9 6315.3 5825.4 5827.9 5830.6 5832.0 5842.2 5315.0 6179.4 6207.4 6273.6 6283.5 6158.4 6170.5 6178.0 6179.5 6186.4 6270.6 6290.8 6293.8 6294.7 6296.7 6043.1 6095.5 6119.9 6206.9 6238.3 6123.8 6129.0 6147.2 6197.3 6206.0 4877.5 4909.8 4910.3 4923.4 4928.9 4362.5 4393.6 4415.6 4422.7 4440.9 5548.4 5646.2 5661.1 5682.5 5747.4 6141.5 6158.9 6163.1 6205.3 6293.7 5705.2 5709.0 5716.3 5750.3 5753.1 5309.0 5350.9 5354.8 5362.1 5369.5 6172.2 6206.0 6241.1 6280.5 6290.1 6276.5 6293.9 6294.3 6300.6 6316.8 6231.0 6257.7 6266.0 6267.2 6281.4 6028.5 6125.6 6131.8 6214.9 6223.0 4673.3 5912.0 6202.1 6277.1 6295.3 5950.3 6088.4 6092.8 6112.4 6119.3 6042.9 6111.0 6118.7 6119.0 6134.6 5923.7 5944.1 5950.8 5951.3 5976.4 5923.0 6062.9 6115.3 6130.4 6132.9 5954.2 5963.4 6001.4 6019.2 6044.1 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:59317.07 Median:36069.87 stddev:115987.04 (321.6%) stddev-sans-first:116228.34 08:13:08 INFO - PROCESS | 1670 | Values: 496.5 536.4 585.8 646.9 650.3 33708.8 39212.8 39250.0 39425.0 39528.0 41688.8 42204.8 42232.6 42263.0 42403.0 8350.2 8357.3 9432.8 9671.3 9671.8 9549.2 9687.7 9723.5 9812.4 9814.3 9754.7 9842.2 9845.2 9849.5 9875.1 9766.8 9810.2 9820.1 9820.8 9829.7 9612.6 9742.6 9747.8 9766.5 9769.1 41156.6 41326.6 41476.0 41568.8 41576.8 3144.2 3195.7 3282.3 3427.6 3702.9 29579.6 30792.7 31421.8 31443.5 31500.8 2752.2 2771.7 2845.3 2900.4 2902.5 386842.0 391937.0 392759.0 393546.0 393750.0 68744.0 70496.6 70613.9 75806.6 75872.0 77455.2 79307.0 79531.0 79602.6 79681.0 17054.5 17246.6 17275.0 17321.5 17329.9 12917.9 12985.4 13003.4 13020.5 13023.1 22083.2 23398.8 23418.9 23504.9 23531.5 10036.7 10202.4 10342.6 10345.3 10373.7 1023.3 1079.6 1112.4 1141.2 1145.1 24298.6 28772.0 28919.6 29447.4 29581.9 1105.2 1130.7 1178.0 1194.8 1226.9 14343.4 14606.4 14632.3 14657.8 14938.8 519625.0 527015.0 528876.0 532063.0 534117.0 59472.4 59789.1 59957.4 60201.7 60239.4 1343.8 1435.2 1491.8 1496.5 1630.7 25884.2 26454.7 29146.6 29524.3 29897.9 46379.3 47424.3 47963.5 48107.8 48201.5 372215.0 375423.0 375651.0 375977.0 376953.0 28286.0 32547.5 33808.8 34165.8 34229.8 42356.8 43630.0 43686.6 44100.0 45068.5 32483.0 34273.7 36020.3 36119.5 36849.8 29576.9 35280.6 35605.8 35688.0 35930.6 29685.0 35216.3 35667.5 36460.6 36551.5 28422.1 31306.0 31793.0 31859.7 32198.4 19931.3 23209.8 23926.0 24264.8 24497.5 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33512.82 Median:14260.84 stddev:101153.29 (709.3%) stddev-sans-first:101406.38 08:13:08 INFO - PROCESS | 1670 | Values: 337.9 361.3 366.5 370.2 370.8 19620.9 20234.3 20397.2 20825.9 20865.4 19498.7 20333.4 20415.2 20542.9 20583.4 5643.5 5800.5 5803.6 5847.1 5873.6 4142.7 4254.3 4444.4 5680.3 6288.9 6242.8 6251.5 6257.0 6258.5 6264.3 5567.9 5825.6 5828.5 6209.4 6260.6 3745.7 3924.0 5337.5 5584.3 5585.6 12826.7 13001.5 13018.9 18926.4 25752.7 1940.5 2110.0 2194.2 2257.9 2768.9 9684.5 9782.2 9900.8 9950.8 10033.6 1706.4 1712.3 1739.7 1767.8 1945.9 72633.6 100029.0 107307.0 107542.0 109378.5 11034.6 11219.7 11233.3 11267.6 11535.9 13697.7 13727.6 13749.2 13785.9 13788.4 7657.0 7936.6 8303.3 8471.3 8568.4 8533.1 8568.0 8590.1 8664.6 8715.0 4412.0 4494.3 4501.4 4546.8 4560.2 1601.5 1835.8 1905.6 1916.5 1941.5 915.5 927.5 950.9 1001.4 1055.5 18963.4 20229.7 20603.8 20806.4 20861.3 904.3 909.4 941.8 963.2 971.9 9061.4 9291.0 10394.8 10743.7 11067.5 579079.0 583128.0 629813.0 632253.0 632359.0 104140.0 104260.4 108072.0 108385.1 110935.0 1061.4 1076.6 1096.5 1096.8 1098.1 15181.9 18010.8 19002.3 19021.8 19284.6 48574.0 51272.7 51900.0 52579.9 52927.5 68559.0 68906.7 69285.0 69400.3 69548.0 7672.4 7765.1 7847.7 7975.6 8158.7 7566.9 11542.3 11635.5 11658.8 12501.7 10726.2 10774.4 10881.4 10979.1 11109.9 7674.5 10570.5 10659.0 10850.5 10878.4 9278.8 10195.6 10589.4 11383.8 11409.6 7406.4 7654.0 7707.0 7727.8 8121.7 10451.2 10650.9 10874.9 10902.5 10932.6 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6036.91 Median:5541.32 stddev:3140.39 (56.7%) stddev-sans-first:3129.69 08:13:08 INFO - PROCESS | 1670 | Values: 1380.4 1463.0 1655.0 1896.5 2068.4 7837.7 8645.3 8814.8 8818.3 8858.4 8450.3 8638.4 8644.1 8683.0 8696.4 2447.0 2473.2 2475.7 2478.9 2486.7 2422.1 2488.3 2489.4 2491.8 2503.5 2466.1 2486.6 2503.5 2510.3 2510.5 2455.9 2477.7 2487.3 2488.4 2495.6 2442.5 2468.3 2477.8 2483.1 2493.9 8800.4 8837.7 8842.6 8854.3 8891.9 4537.7 5521.4 5525.7 5568.1 5589.7 3570.1 3637.2 3681.2 3707.4 3708.6 1023.0 1033.7 1035.9 1038.7 1047.1 11725.8 11760.6 11799.4 11803.4 11812.5 4837.7 4852.1 4857.1 4908.6 4974.4 8979.4 9969.1 10148.9 10165.2 10171.0 5375.8 5458.9 5525.3 5537.3 5545.3 4376.3 4499.0 4773.7 4933.7 5026.8 3892.5 3976.6 3979.6 3987.5 4037.7 1316.2 1317.6 1323.6 1325.6 1337.9 973.1 977.3 992.3 1079.6 1093.7 7987.8 8122.1 8124.9 8145.7 8163.3 1089.5 1166.6 1204.7 1212.4 1241.0 6278.8 6317.3 6318.1 6318.2 6334.1 8457.7 10194.0 10425.8 10428.6 10533.2 10305.1 10327.4 10424.6 10425.7 10428.4 8161.3 8350.5 8356.1 8364.9 8373.3 8058.0 8154.4 8251.3 8306.3 8332.3 9286.5 9643.8 9671.4 9688.2 9742.1 9489.6 9754.8 9792.0 9931.4 9956.1 6803.7 6982.9 7324.5 7562.5 7686.2 8267.5 8299.3 8336.0 8343.2 8352.3 7051.5 7308.3 7312.0 7441.3 7484.4 7098.3 7244.7 7298.5 7303.6 7372.5 7661.2 7737.1 7753.7 7767.5 7769.4 6976.5 6982.1 7068.8 7091.0 7093.8 7118.7 7156.6 7157.0 7172.5 7190.1 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5723.93 Median:6485.17 stddev:1806.52 (27.9%) stddev-sans-first:1765.48 08:13:08 INFO - PROCESS | 1670 | Values: 320.9 329.2 332.0 334.6 340.7 6603.1 6604.5 6613.7 6619.7 6702.7 6503.6 6549.2 6560.3 6566.1 6568.1 4638.7 4738.5 4755.2 4903.3 4932.3 4856.0 4863.3 4876.1 4883.8 4884.6 4802.4 4808.7 4811.0 4827.7 4850.6 4629.7 4723.9 4819.8 4820.0 4848.4 4122.3 4144.5 4146.4 4149.5 4156.9 5069.7 6250.2 6270.9 6275.3 6293.5 5646.7 5657.2 5661.1 5670.5 5672.8 5818.3 6743.8 6880.2 6902.5 6925.5 4495.7 4649.7 4660.3 4699.5 4700.4 7141.4 7334.4 7346.0 7352.6 7374.6 4778.5 4779.3 4780.1 4782.8 4784.0 4832.1 4838.0 4842.3 4845.2 4850.8 4657.3 5679.9 5684.5 5692.9 5695.2 5724.4 6659.5 6976.8 6992.1 6993.6 1669.1 1673.9 1684.6 1686.9 1688.1 1039.6 1045.3 1106.3 1111.4 1134.7 6375.4 6442.0 6445.8 6456.9 6481.3 5938.0 7211.3 7250.5 7256.3 7271.9 6223.8 6489.0 6634.6 6638.6 6640.6 3808.4 3852.3 3855.0 3855.1 3855.6 7303.9 7620.8 7626.4 7653.7 7669.9 7451.1 7509.1 7515.2 7517.1 7537.7 7615.0 7618.9 7624.8 7632.4 7637.2 7020.2 7185.8 7249.4 7256.2 7293.0 7127.6 7159.4 7168.4 7186.5 7186.6 7597.4 7608.0 7612.0 7618.3 7632.0 4569.1 4627.9 4637.6 4638.8 4639.6 6951.0 7258.0 7259.7 7275.5 7282.2 6968.4 7033.4 7033.6 7039.6 7045.9 6948.1 6986.0 6986.1 6998.7 7002.5 5602.6 6758.0 6805.0 6808.4 6808.8 5818.7 6736.7 6946.6 6950.7 6952.4 6586.2 6770.5 6777.7 6790.6 6853.6 08:13:08 INFO - PROCESS | 1670 | 08:13:08 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:17983.60 Median:65289.17 stddev:24913.57 (38.2%) stddev-sans-first:24949.68 08:13:08 INFO - PROCESS | 1670 | Values: 704.3 745.3 768.2 780.3 827.3 14952.3 15040.5 15289.6 15314.2 15314.3 14355.4 14413.4 14458.9 14460.4 14465.6 746.6 757.1 895.4 917.4 929.7 919.9 921.4 922.3 923.6 925.2 977.8 979.2 979.4 979.5 981.1 775.3 954.8 968.7 970.3 972.2 731.1 731.8 732.5 733.0 735.7 15247.5 15341.2 15364.5 15376.0 15384.0 12599.0 12604.9 12642.2 12777.8 12938.8 9903.5 9975.9 10045.0 10100.2 10395.2 3492.3 3525.8 3532.8 3560.6 3617.0 75533.5 76741.6 76975.2 77842.1 80185.2 9263.8 9437.4 9444.2 9660.6 9733.3 20859.5 21321.8 21350.1 21358.5 21390.4 7434.1 7567.9 7580.5 7596.2 7696.5 4124.5 4130.6 4199.5 4200.2 4230.7 3606.7 3646.2 3651.4 3652.8 3653.1 618.3 661.5 677.5 678.0 680.4 496.5 503.9 528.5 587.1 614.0 7928.6 8004.8 8074.4 8128.3 8155.6 573.6 592.0 601.4 607.3 625.6 3319.3 3601.5 3761.2 3818.3 3820.1 87357.6 87685.6 88253.2 91990.0 92240.1 74136.9 75648.0 75951.6 76581.0 76773.0 67029.7 68208.7 68569.6 68684.0 69116.7 8397.5 8398.7 8408.2 8539.3 8631.1 47930.0 49187.0 49687.0 50011.5 50799.7 60625.7 65001.7 65576.7 68658.7 71682.3 11081.8 11099.4 11110.5 11152.8 11303.3 11709.5 11846.9 11942.3 12191.0 12638.1 11287.9 11296.0 11450.0 11478.8 11699.9 10837.4 10885.5 11054.3 11122.6 11232.7 10665.0 10777.4 11035.6 11057.0 12086.4 9360.5 9426.3 9462.5 9468.8 9839.5 9323.6 9428.7 9578.1 9589.8 9667.1 08:13:08 INFO - PROCESS | 1670 | -------- Summary: end -------- 08:13:08 INFO - PROCESS | 1670 | 08:13:09 INFO - TEST-INFO | 1670: exit 0 08:13:09 INFO - TEST-OK | dromaeo_css | took 1113423ms 08:13:09 INFO - TEST-START | kraken 08:13:09 INFO - operating with platform_type : mac_ 08:13:09 INFO - Initialising browser for kraken test... 08:13:09 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpf3nNJ1/profile http://localhost:49273/getInfo.html) 08:13:11 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 08:13:11 INFO - PROCESS | 1676 | colorDepth:24 08:13:11 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 08:13:11 INFO - PROCESS | 1676 | __metrics 08:13:11 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:13:11 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:13:12 INFO - TEST-INFO | 1676: exit 0 08:13:12 INFO - Browser initialized. 08:13:12 INFO - Running cycle 1/1 for kraken test... 08:13:12 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpf3nNJ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:24 INFO - PROCESS | 1678 | RSS: Main: 247300096 08:13:24 INFO - PROCESS | 1678 | 08:13:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 08:13:27 INFO - PROCESS | 1678 | RSS: Main: 291954688 08:13:27 INFO - PROCESS | 1678 | 08:13:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 08:13:30 INFO - PROCESS | 1678 | RSS: Main: 302596096 08:13:30 INFO - PROCESS | 1678 | 08:13:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 08:13:34 INFO - PROCESS | 1678 | RSS: Main: 286789632 08:13:34 INFO - PROCESS | 1678 | 08:13:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 08:13:37 INFO - PROCESS | 1678 | RSS: Main: 288612352 08:13:37 INFO - PROCESS | 1678 | 08:13:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:13:39 INFO - PROCESS | 1678 | RSS: Main: 290209792 08:13:39 INFO - PROCESS | 1678 | 08:13:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 08:13:43 INFO - PROCESS | 1678 | RSS: Main: 291745792 08:13:43 INFO - PROCESS | 1678 | 08:13:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 08:13:46 INFO - PROCESS | 1678 | RSS: Main: 291270656 08:13:46 INFO - PROCESS | 1678 | 08:13:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 08:13:50 INFO - PROCESS | 1678 | RSS: Main: 292048896 08:13:50 INFO - PROCESS | 1678 | 08:13:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:52 INFO - PROCESS | 1678 | RSS: Main: 325316608 08:13:52 INFO - PROCESS | 1678 | 08:13:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:54 INFO - PROCESS | 1678 | RSS: Main: 324620288 08:13:54 INFO - PROCESS | 1678 | 08:13:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:57 INFO - PROCESS | 1678 | RSS: Main: 332582912 08:13:57 INFO - PROCESS | 1678 | 08:13:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:00 INFO - PROCESS | 1678 | RSS: Main: 334012416 08:14:00 INFO - PROCESS | 1678 | 08:14:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:03 INFO - PROCESS | 1678 | RSS: Main: 333832192 08:14:03 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 08:14:05 INFO - PROCESS | 1678 | RSS: Main: 394518528 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | __start_tp_report 08:14:05 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 08:14:05 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 08:14:05 INFO - PROCESS | 1678 | |i|pagename|runs| 08:14:05 INFO - PROCESS | 1678 | |0;ai-astar;110;107;111;110;111;112;116;112;112;112 08:14:05 INFO - PROCESS | 1678 | |1;audio-beat-detection;157;119;144;156;117;141;140;118;160;119 08:14:05 INFO - PROCESS | 1678 | |2;audio-dft;185;185;185;184;184;186;185;186;184;181 08:14:05 INFO - PROCESS | 1678 | |3;audio-fft;78;69;82;78;56;58;59;80;77;54 08:14:05 INFO - PROCESS | 1678 | |4;audio-oscillator;93;92;126;80;77;84;116;79;80;117 08:14:05 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;87;83;86;84;87;82;87;83;85;83 08:14:05 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;93;92;92;92;91;93;93;92;92 08:14:05 INFO - PROCESS | 1678 | |7;imaging-desaturate;103;133;114;84;87;86;86;85;85;85 08:14:05 INFO - PROCESS | 1678 | |8;json-parse-financial;56;53;53;55;53;54;55;65;53;51 08:14:05 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;64;65;79;75;71;67;67;68;70;67 08:14:05 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;84;83;82;83;83;82;83;81;86;80 08:14:05 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;125;120;132;121;119;119;119;134;129;132 08:14:05 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;142;122;139;138;137;136;136;139;137;137 08:14:05 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;67;72;94;94;74 08:14:05 INFO - PROCESS | 1678 | __end_tp_report 08:14:05 INFO - PROCESS | 1678 | __start_cc_report 08:14:05 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1201 08:14:05 INFO - PROCESS | 1678 | __end_cc_report 08:14:05 INFO - PROCESS | 1678 | __startTimestamp1458832445519__endTimestamp 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | ------- Summary: start ------- 08:14:05 INFO - PROCESS | 1678 | Number of tests: 14 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.26 (2.0%) stddev-sans-first:2.35 08:14:05 INFO - PROCESS | 1678 | Values: 110.0 107.0 111.0 110.0 111.0 112.0 116.0 112.0 112.0 112.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:142.50 stddev:17.55 (12.3%) stddev-sans-first:17.08 08:14:05 INFO - PROCESS | 1678 | Values: 157.0 119.0 144.0 156.0 117.0 141.0 140.0 118.0 160.0 119.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 08:14:05 INFO - PROCESS | 1678 | Values: 185.0 185.0 185.0 184.0 184.0 186.0 185.0 186.0 184.0 181.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.10 Median:77.50 stddev:11.21 (14.5%) stddev-sans-first:11.42 08:14:05 INFO - PROCESS | 1678 | Values: 78.0 69.0 82.0 78.0 56.0 58.0 59.0 80.0 77.0 54.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:80.00 stddev:18.40 (23.0%) stddev-sans-first:19.51 08:14:05 INFO - PROCESS | 1678 | Values: 93.0 92.0 126.0 80.0 77.0 84.0 116.0 79.0 80.0 117.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:84.70 Median:85.50 stddev:1.95 (2.3%) stddev-sans-first:1.88 08:14:05 INFO - PROCESS | 1678 | Values: 87.0 83.0 86.0 84.0 87.0 82.0 87.0 83.0 85.0 83.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:14:05 INFO - PROCESS | 1678 | Values: 92.0 93.0 92.0 92.0 92.0 91.0 93.0 93.0 92.0 92.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:85.00 stddev:16.72 (19.7%) stddev-sans-first:17.47 08:14:05 INFO - PROCESS | 1678 | Values: 103.0 133.0 114.0 84.0 87.0 86.0 86.0 85.0 85.0 85.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.85 (7.1%) stddev-sans-first:4.06 08:14:05 INFO - PROCESS | 1678 | Values: 56.0 53.0 53.0 55.0 53.0 54.0 55.0 65.0 53.0 51.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:4.64 (6.7%) stddev-sans-first:4.51 08:14:05 INFO - PROCESS | 1678 | Values: 64.0 65.0 79.0 75.0 71.0 67.0 67.0 68.0 70.0 67.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.64 (2.0%) stddev-sans-first:1.67 08:14:05 INFO - PROCESS | 1678 | Values: 84.0 83.0 82.0 83.0 83.0 82.0 83.0 81.0 86.0 80.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:6.18 (4.9%) stddev-sans-first:6.56 08:14:05 INFO - PROCESS | 1678 | Values: 125.0 120.0 132.0 121.0 119.0 119.0 119.0 134.0 129.0 132.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:137.50 stddev:5.33 (3.9%) stddev-sans-first:5.24 08:14:05 INFO - PROCESS | 1678 | Values: 142.0 122.0 139.0 138.0 137.0 136.0 136.0 139.0 137.0 137.0 08:14:05 INFO - PROCESS | 1678 | 08:14:05 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:70.00 stddev:10.85 (15.5%) stddev-sans-first:11.21 08:14:05 INFO - PROCESS | 1678 | Values: 67.0 68.0 68.0 68.0 67.0 67.0 72.0 94.0 94.0 74.0 08:14:05 INFO - PROCESS | 1678 | -------- Summary: end -------- 08:14:05 INFO - PROCESS | 1678 | 08:14:06 INFO - TEST-INFO | 1678: exit 0 08:14:06 INFO - TEST-OK | kraken | took 56788ms 08:14:06 INFO - SUITE-END | took 1170s 08:14:06 INFO - Completed test suite (00:19:30) 08:14:06 INFO - javascript benchmark 08:14:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.629282632497, 3402.8128452935093, 3506.999999999998, 3551.9822400887992, 3582.4089025310823, 5643.830685079444, 5724.6851423171765, 5724.799632012875, 5729.6848673323, 5732.054211055181, 5081.136206844836, 5442.809501667432, 5716.3426205986325, 5864.149698293745, 5903.409659034094, 5171.043356978971, 5207.062728708831, 5235.607329450288, 5240.213967904807, 5334.759935802898, 5313.0, 5341.1988201769655, 5353.544948679348, 5395.001924643953, 5416.864578385533, 5136.0, 5245.475452454724, 5247.2653828464045, 5266.973665131688, 5290.074237008527, 5191.0, 5214.5046220609365, 5252.080885845, 5283.154695248781, 5288.048151332759, 5245.947540524584, 5258.1061219592375, 5259.3951695555115, 5270.2358158067245, 5294.364676238876, 5616.859578510529, 5628.352739434977, 5632.971835140839, 5642.238297829782, 5645.520130788888, 6043.111230148123, 6117.583823141527, 6246.781362652331, 6256.468200202989, 6271.435570798604, 6222.906656400158, 6227.750889964396, 6277.309495955487, 6314.936850631527, 6315.336889626615, 5825.446582574648, 5827.854303642401, 5830.562707796932, 5832.037713777179, 5842.152887831283, 5314.97342513285, 6179.351168127372, 6207.410296021871, 6273.592216506004, 6283.465905398001, 6158.3841615838055, 6170.5372097092, 6178.0, 6179.5056395488255, 6186.350433204539, 6270.561060725706, 6290.779822706183, 6293.842653933688, 6294.716737746812, 6296.748130074746, 6043.09353596964, 6095.468565591287, 6119.8984182846625, 6206.906896396557, 6238.251409830849, 6123.8162855114415, 6129.014559402219, 6147.170132032208, 6197.25632924052, 6206.038064100072, 4877.5366340197625, 4909.828156014522, 4910.312556242129, 4923.359963204832, 4928.888292772589, 4362.541933097043, 4393.582609652078, 4415.602595766396, 4422.668299877458, 4440.911181776346, 5548.4174161712435, 5646.237757902631, 5661.065924122556, 5682.488576028178, 5747.39652336507, 6141.477974372228, 6158.922188616974, 6163.075538669146, 6205.317415084337, 6293.716782744787, 5705.22979397776, 5709.029464990961, 5716.256886604715, 5750.25246717924, 5753.108268218432, 5309.0, 5350.91973620396, 5354.839354819362, 5362.115250983622, 5369.543588794996, 6172.22847144107, 6205.968970155211, 6241.063840423973, 6280.497560195265, 6290.056491526308, 6276.497880169667, 6293.937060629335, 6294.339094395205, 6300.621962682254, 6316.842078948063, 6230.968845155745, 6257.687115644108, 6265.96867015662, 6267.2165979252595, 6281.434670879643, 6028.457438830526, 6125.571219981412, 6131.774283661862, 6214.875702486015, 6223.0, 4673.252279635242, 5912.0, 6202.069689546604, 6277.12120303167, 6295.338989406229, 5950.31571369298, 6088.4215999479975, 6092.75628974836, 6112.449879510866, 6119.296280927572, 6042.909356359746, 6110.984061328701, 6118.724657390339, 6118.9846826261555, 6134.589663226307, 5923.733431995657, 5944.138099975393, 5950.761969521171, 5951.345352011189, 5976.402359763989, 5923.0, 6062.90905636407, 6115.327313995368, 6130.356312587114, 6132.8773424532155, 5954.166416701752, 5963.403659634002, 6001.3698561652145, 6019.247594050744, 6044.063170208625], "unit": "score", "name": "dojo.html", "value": 5692.664190622009}, {"lowerIsBetter": false, "replicates": [496.45142117959676, 536.3617295418452, 585.7510558012846, 646.8738595973786, 650.2749434380665, 33708.831455842716, 39212.80393598035, 39250.0, 39425.0, 39528.01179970499, 41688.791556042175, 42204.788976055155, 42232.57767422325, 42263.0, 42403.0, 8350.206730360605, 8357.289630381425, 9432.81134377312, 9671.274654400913, 9671.806563868719, 9549.188318992894, 9687.660931867385, 9723.46520941348, 9812.411255324667, 9814.312998090101, 9754.658586949457, 9842.163416109639, 9845.212383009379, 9849.458279794608, 9875.1112399884, 9766.755831104208, 9810.166135878459, 9820.116189542976, 9820.754481138028, 9829.705108846745, 9612.615495380176, 9742.561584728634, 9747.756306092333, 9766.462844543546, 9769.120779129842, 41156.588434115576, 41326.58673413257, 41476.0, 41568.792156039024, 41576.79211603923, 3144.213946513372, 3195.680431956809, 3282.3271229397915, 3427.5715535558056, 3702.8518859245596, 29579.556306655417, 30792.69207307943, 31421.84289078563, 31443.52834707481, 31500.842495787605, 2752.160591019738, 2771.6673999120035, 2845.271072417899, 2900.419916016805, 2902.4630443368046, 386842.0, 391937.04031479947, 392759.0, 393546.0, 393750.0, 68744.0, 70496.64751676311, 70613.94079088818, 75806.62096689592, 75872.0, 77455.22544774594, 79307.0, 79531.0, 79602.60198699085, 79681.0, 17054.488365349058, 17246.568835778955, 17275.049872257146, 17321.480355589352, 17329.91335043342, 12917.870821291855, 12985.415656295301, 13003.414846331749, 13020.544280950122, 13023.088383813041, 22083.227087051877, 23398.76601234, 23418.882905585702, 23504.882475587514, 23531.52936941286, 10036.749081272881, 10202.438865862301, 10342.586296548205, 10345.327553708985, 10373.688789336333, 1023.2581378500528, 1079.551985925832, 1112.360392774158, 1141.178351586856, 1145.0782120393164, 24298.635520467207, 28772.0, 28919.56620650692, 29447.411051778843, 29581.85209073941, 1105.1932089574655, 1130.6721050895312, 1177.9823302650468, 1194.814803705427, 1226.9447874845653, 14343.354549045318, 14606.415743370359, 14632.268386580628, 14657.780133298009, 14938.775918361232, 519625.0, 527015.0, 528876.0, 532063.0, 534117.0, 59472.40527594669, 59789.103163452586, 59957.40042599606, 60201.69899150564, 60239.39760602426, 1343.7648411527944, 1435.2464955898238, 1491.7986071880591, 1496.5285934930462, 1630.6657135287237, 25884.22347329583, 26454.735452645225, 29146.56280155757, 29524.261893452836, 29897.850510748176, 46379.30431043605, 47424.28863567118, 47963.520364795906, 48107.75946120247, 48201.517984821105, 372215.0, 375423.0, 375651.0, 375977.0, 376953.0, 28286.0, 32547.51178732368, 33808.830955846046, 34165.829170853984, 34229.828850855585, 42356.788216058725, 43630.0, 43686.56313436825, 44100.0, 45068.54931450643, 32483.0, 34273.65726342705, 36020.27959440849, 36119.45820812637, 36849.81575092107, 29576.852115739282, 35280.64719352876, 35605.82197088998, 35688.0, 35930.64069359273, 29685.0, 35216.29567408689, 35667.46498802468, 36460.63539364572, 36551.45172822463, 28422.147335579964, 31306.0, 31793.0, 31859.68140318567, 32198.35603287968, 19931.302404416358, 23209.767902321437, 23926.0, 24264.757352426248, 24497.51004979926], "unit": "score", "name": "ext.html", "value": 19938.419603067894}, {"lowerIsBetter": false, "replicates": [337.88005258133364, 361.2792479004387, 366.5216891955998, 370.1671239710651, 370.8442454169249, 19620.90189549052, 20234.29179978701, 20397.184112635514, 20825.895870520628, 20865.37403877886, 19498.707519387186, 20333.389998300074, 20415.183392664276, 20542.89728551355, 20583.382498525032, 5643.548516118711, 5800.47795698387, 5803.564732645047, 5847.122931560279, 5873.559483038768, 4142.689298302625, 4254.298040823261, 4444.377787109807, 5680.318361796591, 6288.8742225155465, 6242.843928901769, 6251.468625166866, 6256.998880179172, 6258.499320054385, 6264.279607845087, 5567.944320556783, 5825.592208545403, 5828.475437210672, 6209.410106039919, 6260.593061451013, 3745.681617062553, 3923.9607603923882, 5337.492938170868, 5584.329880414336, 5585.553155747531, 12826.679333016657, 13001.479940802357, 13018.86981130186, 18926.43220703381, 25752.74247257541, 1940.534271774764, 2109.9683504747286, 2194.1771835561663, 2257.932262032142, 2768.9446211075865, 9684.46735429558, 9782.217422606245, 9900.80198396028, 9950.751231219278, 10033.598656053822, 1706.3771723321022, 1712.2808420463434, 1739.6955532781712, 1767.7790276215474, 1945.8832470051843, 72633.63683181602, 100029.0, 107307.0, 107542.0, 109378.45310773475, 11034.558617655204, 11219.66341009771, 11233.32600044, 11267.605633802777, 11535.884641153649, 13697.657558561115, 13727.588172354845, 13749.243791591358, 13785.862141378459, 13788.379522921492, 7656.966309548251, 7936.563489008045, 8303.252707256375, 8471.322294216448, 8568.400211985227, 8533.146685331541, 8567.957160214284, 8590.055093939662, 8664.566771661392, 8714.956425217833, 4411.955880441219, 4494.280915053641, 4501.41481607389, 4546.795394207269, 4560.224761790503, 1601.5355546891503, 1835.7888842782984, 1905.6188762247607, 1916.4633902507042, 1941.5437372217518, 915.5330781301584, 927.452802846324, 950.9144177024101, 1001.3841487485145, 1055.4933631856752, 18963.43109706711, 20229.696554551694, 20603.79396206049, 20806.375808725763, 20861.269855554983, 904.3307952115388, 909.3589019741066, 941.8257622339752, 963.2307117038514, 971.868797712314, 9061.365704400629, 9291.0, 10394.792104158027, 10743.731406714895, 11067.50196241171, 579079.0, 583128.0, 629813.0, 632253.0, 632359.0, 104140.0, 104260.43609345866, 108072.0, 108385.0978087069, 110935.0, 1061.4207475833798, 1076.5586109695143, 1096.528492748126, 1096.8299913513258, 1098.1434481104752, 15181.924090379478, 18010.819891800915, 19002.334918277793, 19021.809781902557, 19284.614307713488, 48574.0, 51272.74363628158, 51899.96200075902, 52579.896804127406, 52927.470725293795, 68559.0, 68906.65546672234, 69284.96072558814, 69400.30599693938, 69548.0, 7672.424568157299, 7765.107012693613, 7847.725329613436, 7975.5613441261285, 8158.673653053811, 7566.886496702444, 11542.307461552333, 11635.47640356169, 11658.76682466363, 12501.74996500083, 10726.195535334726, 10774.353538787698, 10881.401522916316, 10979.066779323846, 11109.944450277697, 7674.462787605037, 10570.524326405177, 10659.0, 10850.45747712627, 10878.40168790724, 9278.814423711354, 10195.592176312864, 10589.417582032755, 11383.829242561202, 11409.60066397672, 7406.4074874008875, 7654.0, 7707.0, 7727.768166955, 8121.715739949073, 10451.16390688728, 10650.89349106499, 10874.891251087703, 10902.50938707776, 10932.56269749201], "unit": "score", "name": "jquery.html", "value": 9096.18721577958}, {"lowerIsBetter": false, "replicates": [1380.4271227440609, 1462.9707405851889, 1655.0400767554816, 1896.5448292409817, 2068.400163952453, 7837.686492540299, 8645.26515246204, 8814.823703525926, 8818.250448711868, 8858.424202426853, 8450.323974082074, 8638.438501497414, 8644.092370301121, 8682.956585217082, 8696.434731742433, 2446.9510609787794, 2473.1714875516723, 2475.7400472950353, 2478.8884500197532, 2486.676732024834, 2422.1280339077916, 2488.30327508298, 2489.427431690712, 2491.750824917512, 2503.5493611149986, 2466.075221791828, 2486.627005949113, 2503.4993001399703, 2510.3222130024883, 2510.5104504621604, 2455.852648841066, 2477.702675678921, 2487.2911220302217, 2488.427661637815, 2495.563276426636, 2442.5237078769646, 2468.25952214335, 2477.764612361823, 2483.1060818105466, 2493.875306234699, 8800.427972181787, 8837.734867953972, 8842.646294148291, 8854.335924805666, 8891.911080889173, 4537.727736335797, 5521.365043020064, 5525.696086715229, 5568.136938774496, 5589.692566908819, 3570.1431656402538, 3637.1634524059614, 3681.226942342111, 3707.4068149096283, 3708.629137086297, 1022.964196253135, 1033.736397218712, 1035.8705161854768, 1038.693585392311, 1047.0890325416935, 11725.824112638316, 11760.588379406765, 11799.351035693033, 11803.350815705218, 11812.468438920268, 4837.69382266786, 4852.126617208936, 4857.077155340474, 4908.631852611068, 4974.403071631427, 8979.371443998858, 9969.052939970692, 10148.898511014942, 10165.186785057178, 10171.033751793568, 5375.81184658535, 5458.863528411742, 5525.281713377235, 5537.335519737658, 5545.306836645419, 4376.299792033323, 4498.977505112453, 4773.737444440589, 4933.703977761345, 5026.824061157842, 3892.4550562921213, 3976.6421022108148, 3979.5622481527007, 3987.4616926715103, 4037.7375470594316, 1316.230005446805, 1317.5783749200355, 1323.589687196972, 1325.6288239293012, 1337.8595247498872, 973.124188230584, 977.2524019125375, 992.3153024413276, 1079.63292480557, 1093.6664317383115, 7987.760367188994, 8122.065962414398, 8124.878126828103, 8145.714899978472, 8163.346932245406, 1089.455272363818, 1166.6383421139474, 1204.6687161030786, 1212.4119801896074, 1241.0381953985734, 6278.780242691484, 6317.305096439388, 6318.083877837687, 6318.178636777189, 6334.144890439732, 8457.746267611981, 10194.031567001122, 10425.843612345821, 10428.634997775041, 10533.157347412189, 10305.103541141694, 10327.380357178594, 10424.583016679248, 10425.739356516147, 10428.374297542172, 8161.306288965386, 8350.498970061693, 8356.122607126164, 8364.874526882102, 8373.288270497076, 8058.0, 8154.38842086834, 8251.33989280868, 8306.293965013041, 8332.291755200877, 9286.489243091695, 9643.807123857343, 9671.371360861522, 9688.176504997155, 9742.123208911233, 9489.620415183315, 9754.75613109678, 9791.971842956673, 9931.354461959949, 9956.054174853378, 6803.659817009031, 6982.895256571054, 7324.450666199949, 7562.470627056054, 7686.231376862493, 8267.462614930011, 8299.253067223979, 8335.999680038434, 8343.207395297437, 8352.29005534512, 7051.471139664648, 7308.30571095745, 7312.0, 7441.293077157661, 7484.401247900264, 7098.325659062587, 7244.746433874789, 7298.525595836254, 7303.634818259172, 7372.520786148883, 7661.233876612294, 7737.14891361961, 7753.728619498291, 7767.4562780607075, 7769.417293703108, 6976.4767642426, 6982.1272340957385, 7068.787936361918, 7090.964545177241, 7093.82265443368, 7118.679659415235, 7156.642167891689, 7157.0, 7172.497925145399, 7190.137183538009], "unit": "score", "name": "mootools.html", "value": 4926.439987016793}, {"lowerIsBetter": false, "replicates": [320.87004763070956, 329.18526646549793, 331.9983400082999, 334.5801019720251, 340.65083289628143, 6603.075569420279, 6604.537682362236, 6613.669316534172, 6619.702113404896, 6702.664866756667, 6503.609783412999, 6549.214094308678, 6560.278369379364, 6566.1464009678675, 6568.080468734369, 4638.675292729494, 4738.47876733559, 4755.191617425029, 4903.289023091658, 4932.309476673268, 4855.960496591422, 4863.319135321058, 4876.097921884445, 4883.755812209393, 4884.609231261508, 4802.351682522867, 4808.687435316693, 4810.97594512027, 4827.686200396981, 4850.5877000455, 4629.699069560468, 4723.881902952437, 4819.831305904277, 4819.951800481986, 4848.369711937426, 4122.2579935611575, 4144.48193975753, 4146.4402305688645, 4149.481314835645, 4156.896077598054, 5069.695818250917, 6250.1874756281395, 6270.905936410957, 6275.2783429905685, 6293.527985401068, 5646.661200327993, 5657.20799088128, 5661.065924122515, 5670.5463562914865, 5672.829815105553, 5818.3308919474375, 6743.831404214934, 6880.208775990775, 6902.516823822334, 6925.549839260432, 4495.662825288084, 4649.744264065475, 4660.254359302496, 4699.483056863743, 4700.412448443944, 7141.357277845019, 7334.376577990877, 7345.963270183614, 7352.595607241599, 7374.594397308199, 4778.450478194983, 4779.283107533828, 4780.067886762048, 4782.784774685148, 4783.95216047842, 4832.081904438145, 4837.95162048375, 4842.280990248481, 4845.1520983828395, 4850.75746212688, 4657.254839225708, 5679.914801277984, 5684.488396044376, 5692.857678557986, 5695.231143795618, 5724.398938111438, 6659.533832631766, 6976.790696279119, 6992.056072430259, 6993.615351155735, 1669.0986867091876, 1673.9246733897003, 1684.6125391159858, 1686.9156542173089, 1688.0715606416422, 1039.5861628185662, 1045.3048722599538, 1106.303029091667, 1111.3942901118749, 1134.6709454258173, 6375.438017685697, 6442.0, 6445.838854028687, 6456.903146452807, 6481.319461456574, 5937.970310148422, 7211.314925082109, 7250.492465527468, 7256.34692877633, 7271.89092163618, 6223.813285601439, 6489.026646003137, 6634.568753031038, 6638.601683898982, 6640.601563906181, 3808.3906574947873, 3852.287326844487, 3854.995402390741, 3855.055511399669, 3855.614438556122, 7303.89044164338, 7620.771376858703, 7626.36890272855, 7653.732119375906, 7669.923300767033, 7451.105867295959, 7509.098908131059, 7515.173330933593, 7517.097948246136, 7537.736179233701, 7615.048118985127, 7618.885716714143, 7624.847503049908, 7632.427567932427, 7637.236276372319, 7020.22777494465, 7185.820354491179, 7249.420046396381, 7256.1655409628565, 7293.015442915139, 7127.643617819192, 7159.355657990805, 7168.354848063699, 7186.532875363085, 7186.568805871664, 7597.354224890946, 7607.961960190164, 7611.961940190264, 7618.276263754934, 7632.045994250719, 4569.063342014812, 4627.88430289232, 4637.628989680885, 4638.814447422065, 4639.628829693684, 6951.004862720237, 7258.02016727735, 7259.745908893164, 7275.527090739297, 7282.198958114497, 6968.407685346802, 7033.402160816388, 7033.648317584202, 7039.612821294878, 7045.894311585433, 6948.062011628365, 6986.0, 6986.126734158231, 6998.720051197895, 7002.544834585736, 5602.635828671123, 6757.966210169115, 6804.965975170093, 6808.38724514796, 6808.795736127924, 5818.709064546841, 6736.730530778714, 6946.6179360135675, 6950.687219075053, 6952.443804495527, 6586.242582103119, 6770.526063175727, 6777.661116944231, 6790.558613690095, 6853.554518956252], "unit": "score", "name": "prototype.html", "value": 5125.8068681154755}, {"lowerIsBetter": false, "replicates": [704.3027402871156, 745.3105877063718, 768.2471178245316, 780.2977320411629, 827.2596026556232, 14952.327145278461, 15040.473583424582, 15289.617759556017, 15314.157721325322, 15314.310856011492, 14355.425782968694, 14413.351399187035, 14458.855411445882, 14460.421583136662, 14465.638359041002, 746.6304179431189, 757.1444267977178, 895.3821862914584, 917.3578495053456, 929.665320484625, 919.9034101419355, 921.3596550397476, 922.2898368256439, 923.5613083785215, 925.1997022575457, 977.8191034658611, 979.1677074486665, 979.4417182206146, 979.5151400056982, 981.082687687015, 775.2828633514005, 954.8472244440926, 968.6900191938582, 970.3062310447993, 972.2076507646245, 731.0715391452878, 731.8024133483983, 732.4726197138052, 733.0, 735.6542425060213, 15247.542573722805, 15341.156236406992, 15364.542977830011, 15376.000559963566, 15384.0, 12599.0, 12604.936975315157, 12642.178258413174, 12777.808332875014, 12938.805917911239, 9903.504824758733, 9975.850362244571, 10045.0, 10100.191984641211, 10395.16838652906, 3492.2840817632577, 3525.841337139809, 3532.8056956867363, 3560.6439356064448, 3617.0, 75533.48933021363, 76741.61629191875, 76975.23024769737, 77842.05394865117, 80185.19814801894, 9263.814723705487, 9437.386569872937, 9444.150026497648, 9660.613575456902, 9733.318667693335, 20859.478513036993, 21321.78678213229, 21350.14599416037, 21358.466038349165, 21390.358289251348, 7434.1450733166375, 7567.9243207568325, 7580.469367144247, 7596.2023987481625, 7696.499727517694, 4124.463819703419, 4130.56629053945, 4199.517055538652, 4200.222958752641, 4230.746155230696, 3606.6753992140834, 3646.1796095878217, 3651.4157734762844, 3652.7625704329134, 3653.1415117447377, 618.3322012226874, 661.507177153024, 677.4681874728315, 677.9796606101825, 680.4216416046321, 496.5258178439654, 503.85388237411473, 528.5401700520572, 587.0607028754044, 614.0328981853598, 7928.5639289838455, 8004.759857204293, 8074.434789564674, 8128.252843594826, 8155.592220388957, 573.5784198614016, 591.9940800592025, 601.4166258729026, 607.3198018219622, 625.5652321636419, 3319.3195394943978, 3601.4777857210556, 3761.247750449921, 3818.293615681108, 3820.121372084436, 87357.56321218354, 87685.56157219173, 88253.23493530221, 91990.0, 92240.07759922315, 74136.88794668084, 75648.0, 75951.62024189843, 76581.0, 76773.0, 67029.66485167641, 68208.6589567059, 68569.62860742757, 68684.0, 69116.6544167276, 8397.454165479225, 8398.706045288385, 8408.201220884006, 8539.274161696325, 8631.050584435832, 47930.0, 49187.0, 49687.0, 50011.49988500068, 50799.746001269756, 60625.69687151536, 65001.67499162474, 65576.6721166391, 68658.65670671615, 71682.28317716756, 11081.83377249358, 11099.445027748741, 11110.500027498943, 11152.776944460904, 11303.321800691985, 11709.473073711533, 11846.940765296118, 11942.34317112567, 12191.0, 12638.052146088896, 11287.943560282147, 11296.0, 11450.0, 11478.82781758291, 11699.941500292785, 10837.403942782907, 10885.455727213766, 11054.336739795637, 11122.61070862516, 11232.66302010941, 10665.0, 10777.353358798497, 11035.613753518588, 11057.004869561779, 12086.39568021613, 9360.485173315534, 9426.293028022788, 9462.479563624067, 9468.763280918032, 9839.458829764146, 9323.580438880132, 9428.717138485856, 9578.13796758295, 9589.760255993657, 9667.081627245401], "unit": "score", "name": "yui.html", "value": 6899.04518647776}], "name": "dromaeo_css", "value": 7513.301589661796}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 111.0, 110.0, 111.0, 112.0, 116.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [157.0, 119.0, 144.0, 156.0, 117.0, 141.0, 140.0, 118.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.1}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 185.0, 184.0, 184.0, 186.0, 185.0, 186.0, 184.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [78.0, 69.0, 82.0, 78.0, 56.0, 58.0, 59.0, 80.0, 77.0, 54.0], "unit": "score", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 126.0, 80.0, 77.0, 84.0, 116.0, 79.0, 80.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 86.0, 84.0, 87.0, 82.0, 87.0, 83.0, 85.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 92.0, 92.0, 92.0, 91.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.2}, {"lowerIsBetter": true, "replicates": [103.0, 133.0, 114.0, 84.0, 87.0, 86.0, 86.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 94.8}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 53.0, 55.0, 53.0, 54.0, 55.0, 65.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 79.0, 75.0, 71.0, 67.0, 67.0, 68.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 82.0, 83.0, 83.0, 82.0, 83.0, 81.0, 86.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 132.0, 121.0, 119.0, 119.0, 119.0, 134.0, 129.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [142.0, 122.0, 139.0, 138.0, 137.0, 136.0, 136.0, 139.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 72.0, 94.0, 94.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.9}], "name": "kraken", "value": 1410.1}]} 08:14:06 INFO - Return code: 0 08:14:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:14:06 ERROR - # TBPL SUCCESS # 08:14:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:14:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:14:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:14:06 INFO - 2016-03-24 08:14:06.796 screenresolution[1682:9867] starting screenresolution argv=screenresolution get 08:14:06 INFO - 2016-03-24 08:14:06.799 screenresolution[1682:9867] Display 0: 1600x1200x32@60 08:14:06 INFO - 2016-03-24 08:14:06.805 screenresolution[1683:9870] starting screenresolution argv=screenresolution list 08:14:06 INFO - Available Modes on Display 0 08:14:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:14:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:14:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:14:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:07 INFO - Intel Iris: 08:14:07 INFO - Chipset Model: Intel Iris 08:14:07 INFO - Type: GPU 08:14:07 INFO - Bus: Built-In 08:14:07 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:07 INFO - Vendor: Intel (0x8086) 08:14:07 INFO - Device ID: 0x0a2e 08:14:07 INFO - Revision ID: 0x0009 08:14:07 INFO - Displays: 08:14:07 INFO - Display: 08:14:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:07 INFO - Display Serial Number: 1600x1200 60 08:14:07 INFO - Main Display: Yes 08:14:07 INFO - Mirror: Off 08:14:07 INFO - Online: Yes 08:14:07 INFO - Rotation: Supported 08:14:07 INFO - Return code: 0 08:14:07 INFO - Running post-action listener: _resource_record_post_action 08:14:07 INFO - Running post-run listener: _resource_record_post_run 08:14:08 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39679488; Write bytes: 704184832; Read time: 429; Write time: 1982 08:14:08 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 391162368; Write bytes: 380753408; Read time: 28625; Write time: 674 08:14:08 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33418752; Write bytes: 298560512; Read time: 348; Write time: 1259 08:14:08 INFO - Running post-run listener: _upload_blobber_files 08:14:08 INFO - Blob upload gear active. 08:14:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14: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 08:14: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'] 08:14: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 08:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:09 INFO - (blobuploader) - INFO - Done attempting. 08:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:10 INFO - (blobuploader) - INFO - Done attempting. 08:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:10 INFO - Return code: 0 08:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd4cf5acd3fb77638cb1e371a4c4da90337883a28141163ad20a43f4969449dc56202f7045875e04a919a8bd32dd31bb18a06352fa431a1d9d7e787aa3c8700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d36cc3f7db79579e0ffc59e88ea5f303c6a3684e1c9964cad478a9c89afeb10951251727202822e182a33016e975550f4ef8a6ed080fed6646821d15effbf0f"} 08:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:10 INFO - Contents: 08:14:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd4cf5acd3fb77638cb1e371a4c4da90337883a28141163ad20a43f4969449dc56202f7045875e04a919a8bd32dd31bb18a06352fa431a1d9d7e787aa3c8700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d36cc3f7db79579e0ffc59e88ea5f303c6a3684e1c9964cad478a9c89afeb10951251727202822e182a33016e975550f4ef8a6ed080fed6646821d15effbf0f"} 08:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:10 INFO - Copying logs to upload dir... 08:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.495540 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-24 08:14:10.374625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 08:14:10.379063) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/bbd4cf5acd3fb77638cb1e371a4c4da90337883a28141163ad20a43f4969449dc56202f7045875e04a919a8bd32dd31bb18a06352fa431a1d9d7e787aa3c8700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d36cc3f7db79579e0ffc59e88ea5f303c6a3684e1c9964cad478a9c89afeb10951251727202822e182a33016e975550f4ef8a6ed080fed6646821d15effbf0f"} build_url:https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/fiFm_DqtRHugEtvW2g08_g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd4cf5acd3fb77638cb1e371a4c4da90337883a28141163ad20a43f4969449dc56202f7045875e04a919a8bd32dd31bb18a06352fa431a1d9d7e787aa3c8700", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9d36cc3f7db79579e0ffc59e88ea5f303c6a3684e1c9964cad478a9c89afeb10951251727202822e182a33016e975550f4ef8a6ed080fed6646821d15effbf0f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 08:14:10.415553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:14:10.415879) ========= 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.mlHwuX7zhY/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.u9ILnV82YG/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 08:14:10.464280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 08:14:10.467633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 08:14:10.467988) ========= ========= Total master_lag: 13.79 =========