builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1460053879.64 results: success (0) buildid: 20160407104248 builduid: f4ba15b2fbcf4988b3191883a0089476 revision: 16ad4d244d7d34af26301d63862b00a975eac294 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.644752) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.645185) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.645472) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005168 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.668870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.669383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.685639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.686119) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005435 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.766641) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.766946) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.767286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.767556) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 11:31:19-- 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.46M=0.001s 2016-04-07 11:31:19 (8.46 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.907670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.907996) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.019775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:19.959620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 11:31:19.960369) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 16ad4d244d7d34af26301d63862b00a975eac294 --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 16ad4d244d7d34af26301d63862b00a975eac294 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 11:31:20,039 truncating revision to first 12 chars 2016-04-07 11:31:20,040 Setting DEBUG logging. 2016-04-07 11:31:20,040 attempt 1/10 2016-04-07 11:31:20,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/16ad4d244d7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 11:31:21,136 unpacking tar archive at: fx-team-16ad4d244d7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346675 ========= master_lag: 0.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 11:31:21.822268) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:21.822705) ========= echo 16ad4d244d7d34af26301d63862b00a975eac294 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'16ad4d244d7d34af26301d63862b00a975eac294'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 16ad4d244d7d34af26301d63862b00a975eac294 program finished with exit code 0 elapsedTime=0.005337 script_repo_revision: '16ad4d244d7d34af26301d63862b00a975eac294' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:21.848138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:21.848729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 11:31:21.862265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-07 11:31:21.862782) ========= /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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:22 INFO - MultiFileLogger online at 20160407 11:31:22 in /builds/slave/test 11:31:22 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 11:31:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:22 INFO - {'append_to_log': False, 11:31:22 INFO - 'base_work_dir': '/builds/slave/test', 11:31:22 INFO - 'blob_upload_branch': 'Fx-Team', 11:31:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:22 INFO - 'branch': 'Fx-Team', 11:31:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:22 INFO - 'config_files': ('talos/mac_config.py',), 11:31:22 INFO - 'default_actions': ('clobber', 11:31:22 INFO - 'read-buildbot-config', 11:31:22 INFO - 'download-and-extract', 11:31:22 INFO - 'populate-webroot', 11:31:22 INFO - 'create-virtualenv', 11:31:22 INFO - 'install', 11:31:22 INFO - 'run-tests'), 11:31:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:22 INFO - 'download_minidump_stackwalk': True, 11:31:22 INFO - 'download_symbols': 'ondemand', 11:31:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:22 INFO - 'installer_path': 'installer.exe', 11:31:22 INFO - 'log_level': 'info', 11:31:22 INFO - 'log_name': 'talos', 11:31:22 INFO - 'log_to_console': True, 11:31:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:31:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:31:22 INFO - 'opt_config_files': (), 11:31:22 INFO - 'pip_index': False, 11:31:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:31:22 INFO - 'cmd': ('bash', 11:31:22 INFO - '-c', 11:31:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:31:22 INFO - 'enabled': True, 11:31:22 INFO - 'halt_on_failure': False, 11:31:22 INFO - 'name': 'check_screen_resolution'},), 11:31:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:31:22 INFO - 'cmd': ('bash', 11:31:22 INFO - '-c', 11:31:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:31:22 INFO - 'enabled': True, 11:31:22 INFO - 'halt_on_failure': False, 11:31:22 INFO - 'name': 'check_screen_resolution'},), 11:31:22 INFO - 'run_cmd_checks_enabled': True, 11:31:22 INFO - 'sps_profile': False, 11:31:22 INFO - 'sps_profile_interval': 0, 11:31:22 INFO - 'suite': 'dromaeojs', 11:31:22 INFO - 'system_bits': '32', 11:31:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:22 INFO - 'title': 't-yosemite-r7-0143', 11:31:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:22 INFO - 'use_talos_json': True, 11:31:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:22 INFO - 'work_dir': 'build'} 11:31:22 INFO - ##### 11:31:22 INFO - ##### Running clobber step. 11:31:22 INFO - ##### 11:31:22 INFO - Running pre-action listener: _resource_record_pre_action 11:31:22 INFO - Running main action method: clobber 11:31:22 INFO - rmtree: /builds/slave/test/build 11:31:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:23 INFO - Running post-action listener: _resource_record_post_action 11:31:23 INFO - ##### 11:31:23 INFO - ##### Running read-buildbot-config step. 11:31:23 INFO - ##### 11:31:23 INFO - Running pre-action listener: _resource_record_pre_action 11:31:23 INFO - Running main action method: read_buildbot_config 11:31:23 INFO - Using buildbot properties: 11:31:23 INFO - { 11:31:23 INFO - "project": "", 11:31:23 INFO - "product": "firefox", 11:31:23 INFO - "script_repo_revision": "production", 11:31:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:31:23 INFO - "repository": "", 11:31:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:31:23 INFO - "buildid": "20160407104248", 11:31:23 INFO - "pgo_build": "False", 11:31:23 INFO - "basedir": "/builds/slave/test", 11:31:23 INFO - "buildnumber": 637, 11:31:23 INFO - "slavename": "t-yosemite-r7-0143", 11:31:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:31:23 INFO - "platform": "yosemite_r7", 11:31:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:31:23 INFO - "branch": "fx-team", 11:31:23 INFO - "repo_path": "integration/fx-team", 11:31:23 INFO - "revision": "16ad4d244d7d34af26301d63862b00a975eac294", 11:31:23 INFO - "stage_platform": "macosx64", 11:31:23 INFO - "builduid": "f4ba15b2fbcf4988b3191883a0089476", 11:31:23 INFO - "slavebuilddir": "test" 11:31:23 INFO - } 11:31:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:31:23 INFO - Running post-action listener: _resource_record_post_action 11:31:23 INFO - ##### 11:31:23 INFO - ##### Running download-and-extract step. 11:31:23 INFO - ##### 11:31:23 INFO - Running pre-action listener: _resource_record_pre_action 11:31:23 INFO - Running main action method: download_and_extract 11:31:23 INFO - mkdir: /builds/slave/test/build/tests 11:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:23 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:24 INFO - Downloaded 1199 bytes. 11:31:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:31:24 INFO - Using the following test package requirements: 11:31:24 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:31:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:31:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:31:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'jsshell-mac.zip'], 11:31:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:31:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:31:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:31:24 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:31:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:31:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:31:24 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:31:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:24 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:31:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:31:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:31:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:26 INFO - Downloaded 17971735 bytes. 11:31:26 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'] 11:31:26 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 11:31:29 INFO - Return code: 0 11:31:29 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 11:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:29 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:30 INFO - Downloaded 17971735 bytes. 11:31:30 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'] 11:31:30 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 11:31:33 INFO - Return code: 0 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:33 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:35 INFO - Downloaded 10847693 bytes. 11:31:35 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'] 11:31:35 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 11:31:35 INFO - Return code: 0 11:31: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')]} 11:31:35 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 11:31:38 INFO - Downloaded 108875126 bytes. 11:31:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:31:38 INFO - mkdir: /builds/slave/test/properties 11:31:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:38 INFO - Contents: 11:31:38 INFO - build_url:https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:31:39 INFO - Running post-action listener: _resource_record_post_action 11:31:39 INFO - Running post-action listener: set_extra_try_arguments 11:31:39 INFO - ##### 11:31:39 INFO - ##### Running populate-webroot step. 11:31:39 INFO - ##### 11:31:39 INFO - Running pre-action listener: _resource_record_pre_action 11:31:39 INFO - Running main action method: populate_webroot 11:31:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:39 INFO - '--tppagecycles', 11:31:39 INFO - '7'], 11:31:39 INFO - 'tests': ['tsvgm']}}, 11:31:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:31:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['damp', 'tps']}, 11:31:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'tests': ['damp', 'tps']}, 11:31:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['dromaeo_dom']}, 11:31:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['a11yr', 11:31:39 INFO - 'ts_paint', 11:31:39 INFO - 'tpaint', 11:31:39 INFO - 'sessionrestore', 11:31:39 INFO - 'sessionrestore_no_auto_restore', 11:31:39 INFO - 'tabpaint']}, 11:31:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['tsvgx', 11:31:39 INFO - 'tsvgr_opacity', 11:31:39 INFO - 'tart', 11:31:39 INFO - 'tscrollx', 11:31:39 INFO - 'cart']}, 11:31:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:39 INFO - 'tsvgr_opacity', 11:31:39 INFO - 'tart', 11:31:39 INFO - 'tscrollx', 11:31:39 INFO - 'cart']}, 11:31:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'talos_options': ['--disable-e10s'], 11:31:39 INFO - 'tests': ['tp5o']}, 11:31:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'tests': ['tp5o']}, 11:31:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'talos_options': ['--disable-e10s', 11:31:39 INFO - '--xperf_path', 11:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:39 INFO - 'tests': ['tp5n']}, 11:31:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:39 INFO - 'talos_options': ['--xperf_path', 11:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:39 INFO - 'tests': ['tp5n']}}, 11:31:39 INFO - 'talos.zip': {'path': '', 11:31:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:39 INFO - Running post-action listener: _resource_record_post_action 11:31:39 INFO - ##### 11:31:39 INFO - ##### Running create-virtualenv step. 11:31:39 INFO - ##### 11:31:39 INFO - Running pre-action listener: _resource_record_pre_action 11:31:39 INFO - Running main action method: create_virtualenv 11:31:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:39 INFO - Using real prefix '/tools/python27' 11:31:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:43 INFO - Installing pip.................done. 11:31:43 INFO - Return code: 0 11:31:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:43 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:43 INFO - 'HOME': '/Users/cltbld', 11:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:43 INFO - 'LOGNAME': 'cltbld', 11:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:43 INFO - 'MOZ_NO_REMOTE': '1', 11:31:43 INFO - 'NO_EM_RESTART': '1', 11:31:43 INFO - 'PAGER': '/bin/cat', 11:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:43 INFO - 'PWD': '/builds/slave/test', 11:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:43 INFO - 'SHELL': '/bin/bash', 11:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:43 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:43 INFO - 'USER': 'cltbld', 11:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:43 INFO - 'XPC_FLAGS': '0x0', 11:31:43 INFO - 'XPC_SERVICE_NAME': '0', 11:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:31:43 INFO - Cleaning up... 11:31:43 INFO - Return code: 0 11:31:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:43 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:43 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 11:31:43 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 11:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:43 INFO - 'HOME': '/Users/cltbld', 11:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:43 INFO - 'LOGNAME': 'cltbld', 11:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:43 INFO - 'MOZ_NO_REMOTE': '1', 11:31:43 INFO - 'NO_EM_RESTART': '1', 11:31:43 INFO - 'PAGER': '/bin/cat', 11:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:43 INFO - 'PWD': '/builds/slave/test', 11:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:43 INFO - 'SHELL': '/bin/bash', 11:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:43 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:43 INFO - 'USER': 'cltbld', 11:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:43 INFO - 'XPC_FLAGS': '0x0', 11:31:43 INFO - 'XPC_SERVICE_NAME': '0', 11:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:43 INFO - Downloading/unpacking psutil>=0.7.1 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:46 INFO - Installing collected packages: psutil 11:31:46 INFO - Running setup.py install for psutil 11:31:46 INFO - building 'psutil._psutil_osx' extension 11:31:46 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 11:31:46 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 11:31:46 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 11:31:47 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 11:31:47 INFO - building 'psutil._psutil_posix' extension 11:31:47 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 11:31:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:31:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:31:47 INFO - ^ 11:31:47 INFO - 1 warning generated. 11:31:47 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 11:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:47 INFO - Successfully installed psutil 11:31:47 INFO - Cleaning up... 11:31:47 INFO - Return code: 0 11:31:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:47 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:47 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 11:31:47 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 11:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:47 INFO - 'HOME': '/Users/cltbld', 11:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:47 INFO - 'LOGNAME': 'cltbld', 11:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:47 INFO - 'MOZ_NO_REMOTE': '1', 11:31:47 INFO - 'NO_EM_RESTART': '1', 11:31:47 INFO - 'PAGER': '/bin/cat', 11:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:47 INFO - 'PWD': '/builds/slave/test', 11:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:47 INFO - 'SHELL': '/bin/bash', 11:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:47 INFO - 'USER': 'cltbld', 11:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:47 INFO - 'XPC_FLAGS': '0x0', 11:31:47 INFO - 'XPC_SERVICE_NAME': '0', 11:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:31:50 INFO - Installing collected packages: mozsystemmonitor 11:31:50 INFO - Running setup.py install for mozsystemmonitor 11:31:50 INFO - Successfully installed mozsystemmonitor 11:31:50 INFO - Cleaning up... 11:31:50 INFO - Return code: 0 11:31:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:31:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:50 INFO - 'HOME': '/Users/cltbld', 11:31:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:50 INFO - 'LOGNAME': 'cltbld', 11:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:50 INFO - 'MOZ_NO_REMOTE': '1', 11:31:50 INFO - 'NO_EM_RESTART': '1', 11:31:50 INFO - 'PAGER': '/bin/cat', 11:31:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:50 INFO - 'PWD': '/builds/slave/test', 11:31:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:50 INFO - 'SHELL': '/bin/bash', 11:31:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:50 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:50 INFO - 'USER': 'cltbld', 11:31:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:50 INFO - 'XPC_FLAGS': '0x0', 11:31:50 INFO - 'XPC_SERVICE_NAME': '0', 11:31:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:54 INFO - Downloading docopt-0.6.1.tar.gz 11:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:54 INFO - Running setup.py install for blobuploader 11:31:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:54 INFO - Running setup.py install for requests 11:31:54 INFO - Running setup.py install for docopt 11:31:55 INFO - Successfully installed blobuploader requests docopt 11:31:55 INFO - Cleaning up... 11:31:55 INFO - Return code: 0 11:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:55 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:55 INFO - 'HOME': '/Users/cltbld', 11:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:55 INFO - 'LOGNAME': 'cltbld', 11:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:55 INFO - 'MOZ_NO_REMOTE': '1', 11:31:55 INFO - 'NO_EM_RESTART': '1', 11:31:55 INFO - 'PAGER': '/bin/cat', 11:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:55 INFO - 'PWD': '/builds/slave/test', 11:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:55 INFO - 'SHELL': '/bin/bash', 11:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:55 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:55 INFO - 'USER': 'cltbld', 11:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:55 INFO - 'XPC_FLAGS': '0x0', 11:31:55 INFO - 'XPC_SERVICE_NAME': '0', 11:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-PTderG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-wDMEbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Pe1Fvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YJh9CI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-9Hn_Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:55 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-S6vEFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sbOc4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-0GhNov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-u5ROlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-P4bB0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-KyoIl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sNqf0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-a4ra4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-6r6OsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:56 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-h_58UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aPK3Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:57 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-7dstue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:57 INFO - Running setup.py install for manifestparser 11:31:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozcrash 11:31:57 INFO - Running setup.py install for mozdebug 11:31:57 INFO - Running setup.py install for mozdevice 11:31:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:57 INFO - Running setup.py install for mozfile 11:31:57 INFO - Running setup.py install for mozhttpd 11:31:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Running setup.py install for mozinfo 11:31:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Running setup.py install for mozInstall 11:31:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Running setup.py install for mozleak 11:31:58 INFO - Running setup.py install for mozlog 11:31:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Running setup.py install for moznetwork 11:31:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:58 INFO - Running setup.py install for mozprocess 11:31:58 INFO - Running setup.py install for mozprofile 11:31:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:59 INFO - Running setup.py install for mozrunner 11:31:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:59 INFO - Running setup.py install for mozscreenshot 11:31:59 INFO - Running setup.py install for moztest 11:31:59 INFO - Running setup.py install for mozversion 11:31:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:59 INFO - Cleaning up... 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:31:59 INFO - 'HOME': '/Users/cltbld', 11:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PAGER': '/bin/cat', 11:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:31:59 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - 'XPC_FLAGS': '0x0', 11:31:59 INFO - 'XPC_SERVICE_NAME': '0', 11:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-TBMYHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-EE7ebx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-VFQJY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-U7TEVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-b4hprN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-hFsO0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-1JMc6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-u3_Y51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-PV8hZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:00 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-2icRYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:01 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)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-fdzjHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-IGBrpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-cwvdd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-p58uwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-3vRJxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-JQw_lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:01 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rWXmmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:04 INFO - Downloading blessings-1.6.tar.gz 11:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:04 INFO - Installing collected packages: blessings 11:32:04 INFO - Running setup.py install for blessings 11:32:04 INFO - Successfully installed blessings 11:32:04 INFO - Cleaning up... 11:32:04 INFO - Return code: 0 11:32:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:04 INFO - Reading from file tmpfile_stdout 11:32:04 INFO - Current package versions: 11:32:04 INFO - blessings == 1.6 11:32:04 INFO - blobuploader == 1.2.4 11:32:04 INFO - docopt == 0.6.1 11:32:04 INFO - manifestparser == 1.1 11:32:04 INFO - mozInstall == 1.12 11:32:04 INFO - mozcrash == 0.17 11:32:04 INFO - mozdebug == 0.1 11:32:04 INFO - mozdevice == 0.48 11:32:04 INFO - mozfile == 1.2 11:32:04 INFO - mozhttpd == 0.7 11:32:04 INFO - mozinfo == 0.9 11:32:04 INFO - mozleak == 0.1 11:32:04 INFO - mozlog == 3.1 11:32:04 INFO - moznetwork == 0.27 11:32:04 INFO - mozprocess == 0.22 11:32:04 INFO - mozprofile == 0.28 11:32:04 INFO - mozrunner == 6.11 11:32:04 INFO - mozscreenshot == 0.1 11:32:04 INFO - mozsystemmonitor == 0.0 11:32:04 INFO - moztest == 0.7 11:32:04 INFO - mozversion == 1.4 11:32:04 INFO - psutil == 3.1.1 11:32:04 INFO - requests == 1.2.3 11:32:04 INFO - wsgiref == 0.1.2 11:32:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:04 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:32:04 INFO - 'HOME': '/Users/cltbld', 11:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:32:04 INFO - 'LOGNAME': 'cltbld', 11:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:04 INFO - 'MOZ_NO_REMOTE': '1', 11:32:04 INFO - 'NO_EM_RESTART': '1', 11:32:04 INFO - 'PAGER': '/bin/cat', 11:32:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:04 INFO - 'PWD': '/builds/slave/test', 11:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:32:04 INFO - 'SHELL': '/bin/bash', 11:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:32:04 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:32:04 INFO - 'USER': 'cltbld', 11:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:04 INFO - 'XPC_FLAGS': '0x0', 11:32:04 INFO - 'XPC_SERVICE_NAME': '0', 11:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:32:05 INFO - Cleaning up... 11:32:05 INFO - Return code: 0 11:32:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:05 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 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:32:05 INFO - 'HOME': '/Users/cltbld', 11:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PAGER': '/bin/cat', 11:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:32:05 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - 'XPC_FLAGS': '0x0', 11:32:05 INFO - 'XPC_SERVICE_NAME': '0', 11:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:05 INFO - Downloading/unpacking jsonschema 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:07 INFO - Downloading/unpacking functools32 (from jsonschema) 11:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:08 INFO - warning: no files found matching '*.txt' 11:32:08 INFO - no previously-included directories found matching 'build' 11:32:08 INFO - no previously-included directories found matching 'dist' 11:32:08 INFO - no previously-included directories found matching '.git*' 11:32:08 INFO - Installing collected packages: jsonschema, functools32 11:32:08 INFO - Running setup.py install for functools32 11:32:08 INFO - warning: no files found matching '*.txt' 11:32:08 INFO - no previously-included directories found matching 'build' 11:32:08 INFO - no previously-included directories found matching 'dist' 11:32:08 INFO - no previously-included directories found matching '.git*' 11:32:08 INFO - Successfully installed jsonschema functools32 11:32:08 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10353ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10354e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe2488e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, '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.weePXGYQ7j/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.K7XJBI3egZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 11:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:32:08 INFO - 'HOME': '/Users/cltbld', 11:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PAGER': '/bin/cat', 11:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:32:08 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - 'XPC_FLAGS': '0x0', 11:32:08 INFO - 'XPC_SERVICE_NAME': '0', 11:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Downloading/unpacking flake8 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:32:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:32:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:32:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:12 INFO - no previously-included directories found matching 'docs/_build' 11:32:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:32:12 INFO - Running setup.py install for pep8 11:32:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:12 INFO - no previously-included directories found matching 'docs/_build' 11:32:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:32:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:32:12 INFO - Cleaning up... 11:32:12 INFO - Return code: 0 11:32:12 INFO - Running post-action listener: _resource_record_post_action 11:32:12 INFO - Running post-action listener: _start_resource_monitoring 11:32:12 INFO - Starting resource monitoring. 11:32:12 INFO - ##### 11:32:12 INFO - ##### Running install step. 11:32:12 INFO - ##### 11:32:12 INFO - Running pre-action listener: _resource_record_pre_action 11:32:12 INFO - Running main action method: install 11:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:13 INFO - Reading from file tmpfile_stdout 11:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:13 INFO - Reading from file tmpfile_stdout 11:32:13 INFO - Output received: 11:32:13 INFO - Usage: mozinstall [options] installer 11:32:13 INFO - Options: 11:32:13 INFO - -h, --help show this help message and exit 11:32:13 INFO - -d DEST, --destination=DEST 11:32:13 INFO - Directory to install application into. [default: 11:32:13 INFO - "/builds/slave/test"] 11:32:13 INFO - --app=APP Application being installed. [default: firefox] 11:32:13 INFO - mkdir: /builds/slave/test/build/application 11:32:13 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'] 11:32:13 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 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Output received: 11:32:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:32:46 INFO - Running post-action listener: _resource_record_post_action 11:32:46 INFO - ##### 11:32:46 INFO - ##### Running run-tests step. 11:32:46 INFO - ##### 11:32:46 INFO - Running pre-action listener: _resource_record_pre_action 11:32:46 INFO - Running main action method: run_tests 11:32:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:32:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:32:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:32:46 INFO - 2016-04-07 11:32:46.229 screenresolution[1919:11468] starting screenresolution argv=screenresolution get 11:32:46 INFO - 2016-04-07 11:32:46.232 screenresolution[1919:11468] Display 0: 1600x1200x32@60 11:32:46 INFO - 2016-04-07 11:32:46.238 screenresolution[1920:11470] starting screenresolution argv=screenresolution list 11:32:46 INFO - Available Modes on Display 0 11:32:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:32:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:32:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:32:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:32:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:32:46 INFO - Intel Iris: 11:32:46 INFO - Chipset Model: Intel Iris 11:32:46 INFO - Type: GPU 11:32:46 INFO - Bus: Built-In 11:32:46 INFO - VRAM (Dynamic, Max): 1536 MB 11:32:46 INFO - Vendor: Intel (0x8086) 11:32:46 INFO - Device ID: 0x0a2e 11:32:46 INFO - Revision ID: 0x0009 11:32:46 INFO - Displays: 11:32:46 INFO - Display: 11:32:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:32:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:32:46 INFO - Display Serial Number: 1600x1200 60 11:32:46 INFO - Main Display: Yes 11:32:46 INFO - Mirror: Off 11:32:46 INFO - Online: Yes 11:32:46 INFO - Rotation: Supported 11:32:46 INFO - Return code: 0 11:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:46 INFO - Python 2.7.3 11:32:46 INFO - Return code: 0 11:32:46 INFO - grabbing minidump binary from tooltool 11:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:46 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 0x1033dde00>, '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 0x103206db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1033d8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:46 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 11:32:46 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 11:32:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:46 INFO - Return code: 0 11:32:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:32:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:32:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:32:47 INFO - Return code: 0 11:32:47 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 11:32:47 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 11:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.weePXGYQ7j/Render', 11:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:32:47 INFO - 'HOME': '/Users/cltbld', 11:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:32:47 INFO - 'LOGNAME': 'cltbld', 11:32:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:47 INFO - 'MOZ_NO_REMOTE': '1', 11:32:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:47 INFO - 'NO_EM_RESTART': '1', 11:32:47 INFO - 'PAGER': '/bin/cat', 11:32:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:47 INFO - 'PWD': '/builds/slave/test', 11:32:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:32:47 INFO - 'SHELL': '/bin/bash', 11:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.K7XJBI3egZ/Listeners', 11:32:47 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 11:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:32:47 INFO - 'USER': 'cltbld', 11:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:47 INFO - 'XPC_FLAGS': '0x0', 11:32:47 INFO - 'XPC_SERVICE_NAME': '0', 11:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:32:47 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 11:32:47 INFO - mozversion application_buildid: 20160407104248 11:32:47 INFO - mozversion application_changeset: 16ad4d244d7d34af26301d63862b00a975eac294 11:32:47 INFO - mozversion application_display_name: Nightly 11:32:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:47 INFO - mozversion application_name: Firefox 11:32:47 INFO - mozversion application_remotingname: firefox 11:32:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:32:47 INFO - mozversion application_vendor: Mozilla 11:32:47 INFO - mozversion application_version: 48.0a1 11:32:47 INFO - mozversion platform_buildid: 20160407104248 11:32:47 INFO - mozversion platform_changeset: 16ad4d244d7d34af26301d63862b00a975eac294 11:32:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:32:47 INFO - mozversion platform_version: 48.0a1 11:32:47 INFO - using testdate: 1460053967 11:32:47 INFO - actual date: 1460053967 11:32:47 INFO - starting webserver on 'localhost:49732' 11:32:47 INFO - SUITE-START | Running 2 tests 11:32:47 INFO - TEST-START | dromaeo_css 11:32:47 INFO - operating with platform_type : mac_ 11:32:47 INFO - Initialising browser for dromaeo_css test... 11:32:47 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpGoFD74/profile http://localhost:49732/getInfo.html) 11:32:49 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 11:32:49 INFO - PROCESS | 1938 | colorDepth:24 11:32:49 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 11:32:49 INFO - PROCESS | 1938 | __metrics 11:32:50 INFO - PROCESS | 1938 | 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" 11:32:50 ERROR - PROCESS | 1938 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:32:50 INFO - TEST-INFO | 1938: exit 0 11:32:50 INFO - Browser initialized. 11:32:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:50 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpGoFD74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:02 INFO - PROCESS | 1940 | RSS: Main: 236830720 11:33:02 INFO - PROCESS | 1940 | 11:33:53 INFO - PROCESS | 1940 | 1460054033772 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:36:04 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49732/tests/dromaeo/cssquery-ext.html) 11:36:05 INFO - PROCESS | 1940 | RSS: Main: 376442880 11:36:05 INFO - PROCESS | 1940 | 11:39:08 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-ext.html (next: http://localhost:49732/tests/dromaeo/cssquery-jquery.html) 11:39:08 INFO - PROCESS | 1940 | RSS: Main: 366051328 11:39:08 INFO - PROCESS | 1940 | 11:42:11 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49732/tests/dromaeo/cssquery-mootools.html) 11:42:11 INFO - PROCESS | 1940 | RSS: Main: 365830144 11:42:11 INFO - PROCESS | 1940 | 11:45:13 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49732/tests/dromaeo/cssquery-prototype.html) 11:45:14 INFO - PROCESS | 1940 | RSS: Main: 326905856 11:45:14 INFO - PROCESS | 1940 | 11:48:17 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49732/tests/dromaeo/cssquery-yui.html) 11:48:17 INFO - PROCESS | 1940 | RSS: Main: 330555392 11:48:17 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49732/tests/dromaeo/cssquery-yui.html (next: http://localhost:49732/tests/dromaeo/cssquery-dojo.html) 11:51:20 INFO - PROCESS | 1940 | RSS: Main: 373403648 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | __start_tp_report 11:51:20 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 11:51:20 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 11:51:20 INFO - PROCESS | 1940 | |i|pagename|runs| 11:51:20 INFO - PROCESS | 1940 | |0;dojo.html;3352.195473086459;3354.5974483062023;3390.627031026587;3396.5414669019674;3430.6397828228037;5552.278203833496;5613.971930140354;5627.77488900444;5632.35227948785;5637.577181711378;5626.099824028156;5722.771089156428;5733.111367737997;5770.4518070783315;5774.913376299359;5081.46644602317;5114.156164232897;5135.383753949532;5140;5163.096458119833;5126.666766660173;5212.5308722214995;5294.179402192666;5301.125314323132;5311.336082989626;5075.98480303937;5191.792328306863;5216.400113986902;5252.684838909678;5269.604779641523;5119.206522988943;5131.076406246874;5172.663776854492;5194.428612852583;5215.322008138917;5076.6192535559985;5080.568151707109;5085.949140508585;5092.11157289003;5128.8461346159675;5456.781728730846;5522.641028333145;5540.750666220029;5558.277423934863;5574.247476590649;6095.908561371583;6097.146399504073;6127.78552750656;6132.110843927606;6139.093519790236;5492.917606235909;6242.313345531988;6265.404786545271;6274.780382686629;6275.717592708339;5632.324121105412;5740.397258287861;5747.683877386742;5763.366029736726;5765.798197063166;6206.224221972254;6261.24865016201;6262.060690896402;6273.7176827042895;6276.309605943343;6010.939890601126;6020.488258497989;6044.486218671462;6073.453389194994;6079.300880398722;6080.878382432326;6173.59871608344;6244.1570387997035;6249.7187626556915;6257.812265632038;6051.878962420727;6097.433938678448;6108.969455152695;6118.979605063136;6146.801373732169;6149.0776383542825;6150.446459818638;6158.630482171084;6163.84590385244;6167.599106058182;4846.103470857903;4919.36048313724;4925.064237794808;4926.45808961014;4953.529414705597;4401.075774087413;4426.380306757057;4427.424434823452;4471.306947423154;4498.190325741398;5563.36021357541;5627.859303517363;5630.268065151504;5632.2678051853;5639.492445679826;6166.229221347332;6183.907241391383;6232.657203853741;6247.406496382836;6262.3111457739615;5642;5648.774049038075;5658.915116273177;5659.971700141473;5689.231953686282;5270.341207349082;5376.946230537645;5389;5397.9460205397445;5401.243825864382;6245.96877015612;6290.591111577733;6312.810615681537;6314.778982735582;6320.71556779946;6151.292601350723;6194;6195.008798592204;6204.844878877883;6216.160818289473;6212.844678883064;6256.249250090018;6289;6297.527685423704;6301.96849015752;6110.908336375047;6147.569670123048;6157.076438534255;6158.661273629814;6161.353057928853;6174.753009879734;6183.81448556544;6189.381061893775;6191.783287584913;6200.286966998853;5196.480351964925;5931.13998470228;5954.166416701579;5964.493018093511;5999.980003399345;5745.368009519033;5910.645361278337;5929.703514824155;5935.732892019783;6005.549583781147;5810.767569297181;5834.066549352084;5845.240118784531;5861.0915308127305;5870;5975.073863551156;5984.401559843981;5986.760529578768;5998.760049597967;6056;5735;5800.216970708901;5810.593258471867;5833.912491312549;5862.472377486047 11:51:20 INFO - PROCESS | 1940 | |1;ext.html;474.94562072199705;524.5908191610542;566.9773209071637;642.4442856928756;647.9870402591948;37999;38532.80733596331;38546.614533854656;38561.228775424475;38587.42118868216;41723.58276417235;42302.7884860576;42349.36475952855;42406;42452;9463.81072378552;9689.903100969006;9696.660616878411;9712.951435242814;9713.271504637145;9448.196903263231;9595.712128636153;9602.327837051409;9615.13463788259;9625.951870240639;9642.987486313941;9660.855087173699;9754.219662427024;9758.951205243964;9770.022997700244;7937.126916039231;9685.564149613285;9721.368111072758;9756.414615123116;9992.550335234931;9572.47351395673;9707.66023189185;9745.610175592969;9758.463284519348;9766.267529935283;39697.80151099226;40454.190916181804;40737.59262407367;41120.1775964479;41149.79425102855;3230.91922701932;3408.3353746019534;3415.197428604276;3448.2241495663525;3833.5208098987628;27447.313817154532;28870;28916;28916.855415722996;28973.56539651907;2699.5140874642557;2842.3888863894363;2875.3099256178366;2880.6111174991315;2971.257185703574;501842;502907.485462574;505530;505724.7710091592;505879;65323.67338163279;67467.66266168638;67482.32517674859;67532.64934701279;67547;60039;71064.28935710576;71093.28906710866;71220.64389678121;71430.64284678648;15354.309056092503;16923.57691057709;17146.657066858843;17156.828431715774;17291.567710807078;11504.25222360544;11558.30650160993;11564.017058549949;11565.942170289263;11581.420928953687;15444.091755376858;17638.883334000002;20724.792752072288;21340.14639414406;21368.679469807965;7658;8951.686690965915;8968.148025937526;9106.590203440861;9109.498977556297;808.6563210635456;861.7414775567305;932.7574830543972;1009.1573536097441;1012.1801340913884;25405.61891571628;25590.74409255921;26517.46388411078;27652.861735691193;27680.86159569189;902.9864552031725;952.1716106986966;1071.4267866691282;1077.5635867473686;1117.07841031148;13633.522826701217;14025.368858401396;15632.92183539075;15682.294296756674;16097.597560061093;665969;673620;676598;676720;678538;50701;60868.086978695355;60894;61042.69478652578;61128.08307875385;1343.4693296148162;1474.0860666386695;1493.992530037343;1497.6405662641105;1601.7277062899336;27622.3094422633;27660.72339276662;28105.43789124247;28171.71828281691;28197.577036344883;46173.76913115413;46277.53722462867;46931.296030558886;46942;46974.53025469701;394007;397242;397297;398531;398541;27573;27813.582796258477;31461;32056;32591.34817303688;38811;38992.41511377388;39226.41160382539;39731.801340994265;39912.60087399089;33204.83397582997;34415.82792086023;34856.47715284222;34947.47578786371;35183.47224791681;33485;34066.82966585151;34494.13764655904;34726.30547388987;34888.47667284942;33929.49105763465;34091.65908340984;34283.828580856934;34815.12962175966;34970.82514587411;29999.100026999226;30202.54696179603;30280.394392112474;30288.69711302859;30349.089527314216;18732.25070997145;19332.806671933664;23100.422489437897;23303.300900972998;23566 11:51:20 INFO - PROCESS | 1940 | |2;jquery.html;341.6651681352273;365.85183000884643;372.30379190913;376.4052796581401;378.38134649847507;18847.528811779695;19718.915459649714;19776.90111549442;20216.797832021675;20250.987450627483;19335.12991915364;19941.700874486894;20370.981450927433;20629.484262893435;20694.172233110694;5531.723413829312;5695.259616249882;5709.115087161496;5739.655620662774;5763.942360576403;4149.896252593694;4190.51809041961;4296.935545966813;5625.437456254363;5707.4577915098;6299.055141728754;6325.810225693213;6339.71471283791;6342.143810585558;6344.302126766052;6098.756049758004;6219.844503887393;6282.937170628281;6317.526185536057;6318.620882747027;3685.5761587417255;3848.461215429842;3854.094287842355;5384.757685904144;5413.783448662049;24327;25273;25287.49425011508;25426;25439.87280063588;2239.3058151972778;2444.5477586646525;2629.9348763750713;2801.607774911514;2880.0783749200264;13120.47518099275;14255.429782808675;14451.566453006426;15246.313915873701;15300.617484562863;1739.0956702514623;1758.9824101758948;1794.1477798045955;1938.4281636917003;2095.518030852897;79196;105441.47279263631;107785.84428311468;109337;116329.25506117415;15988.36046558148;17336.39322623702;17781;18430.539236519195;18862.90568547176;29508.852455738015;29511.26221844471;29541.113766586608;29569;29664.851675741917;10511.421871796972;10627.256092073636;10652.833375812725;10690;10748.623798167027;7477.887831682529;9053.909460905306;9060.54697265134;9150;9162.770930726785;6641;8526.658933642584;8529.530875801767;8546.78633034179;8633.611487483078;2883.423315336941;2940.9852950735108;3077.584526088994;3148.8349310755166;3380.61064587929;849.7748096754365;884.7566919097171;892.7544925145637;895.7760559859904;926.346925417579;18828.529286767665;18886.622267554845;19109.522261943563;19267.421977340422;19656.606867862847;819.8476856486799;841.1242928269992;927.7634203278121;937.6671281695036;948.2177203806887;9759.463229522444;9853.556589953469;9951.55218015191;10031.548580313904;10084.344517606332;543401;563385;597822;622912;626921;103503.4824825871;107612.4619376898;110329.44835275772;110358.89641103646;110510;1010.3483253301727;1028.3367228137809;1049.7797159008642;1050.0182329521922;1051.106559424483;14239.50161744334;14400.711985760436;16459.84781065314;17074.829251707324;17297.875638083988;38268.04329891775;47529;48327.03345933132;48622.02755944932;48976.51023489719;67223;68686.9696954536;69068.30931690619;69132.30867691258;69172.27069323308;7606.315431611181;7774.961125194338;7838.451308408356;7906.327962123284;8136.674533018613;7981.640826162953;9219.124183202584;9239.491827949527;11475.713107172387;11806.527738890692;8860.424072435271;9099.528904503237;9554.187894028808;10306.48467576633;10422.843657344994;8696.91303086961;9847.553356325228;10469.738256543647;10560.260781745512;10841.970012848768;9928.503574821374;9975.950120249352;10412.32319899204;10544.472776360997;11029.779404412027;7467.962660186664;7635.923640763744;7764.262395072459;7930.603469826601;7958.602069896598;9839.212862971088;10381.11760500366;10513.842292365774;10788.730281743019;10818.67543973682 11:51:20 INFO - PROCESS | 1940 | |3;mootools.html;1351.2230467481202;1404.8314202295724;1629.7066528024955;1853.4254381141848;1967.7048442733587;7935.563544005077;8526.786830329245;8677;8677.305815534757;8714.433561818492;8393;8660.220580147785;8683.91316086839;8691.73924782256;8734.257588105018;2168.2194410012385;2433.4159801647565;2470.1848390031246;2491.451880586277;2496.6130249811217;2494.900203991838;2504.7370026147264;2506.4611108611643;2507.147569826259;2509.648649189115;2423.0671191591277;2475.096589744739;2481.081999660128;2482.515909397668;2495.338735235155;2421.8738286696685;2464.322311364371;2478.157426475007;2487.664165337674;2488;2434.500927309915;2469.1604854349607;2479.194261864883;2489.987550062256;2491.775740183374;8758.124187581254;8804.295656347476;8810.38327317088;8828.8675669865;8851.77870553235;5373.650712703701;5516.613837031409;5528.834134975917;5576.442355764431;5584.553235741131;3485.233248685285;3592.5329707137903;3642.7085833133287;3660.3411385950517;3664.706823454117;917.6008436330218;1074.097757883374;1076.8546246256733;1085.7339951711801;1086.3916206924148;11805.822912656316;11813.29120252779;11814.704632384173;11826.526938922432;11834.585789497327;4806.663533552688;4850.175470170009;4919.385076865392;4919.409670839522;4929.014197160583;10081.445520496443;10095.697129086138;10095.697129086138;10100.444475553768;10123.949380253052;5533.335999679984;5534.0315444797;5537.58468114893;5565.916511252334;5572.164175373727;4424.977875110604;4557.95442045582;4798.736069516141;4952.826651067267;4993.17612593918;3862.845486180521;3973.3642617181113;3976.4035394691027;3997.800109994547;4016.0562267867026;1317.2228385252556;1323.3052647360214;1329.2888304757103;1338.8326459192601;1340.0418700629098;1306.399056434051;1345.8855997240148;1358.721462100267;1359.8776110150134;1385.9792103118461;8137.552434616035;8187.754367368989;8207.343412526983;8224.876626850602;8246.958765206256;528.2762615217177;1256.4848412150975;1257.3964497041472;1316.5260506217753;1327.5751759436887;6194.318624951252;6219.689015549205;6295.590786598948;6300.338464461257;6307.896118179392;10148.898511014942;10477.21420893436;10573.9471302643;10593.046625803714;10631.94684026575;10169.593216271414;10352.741181470523;10438.37369757817;10444.268901176996;10478.947605262078;8195.180481951877;8289.171082891784;8325.583720814057;8405.411621186458;8420.073791882887;7644.923550764644;7685.807854803675;7735.806604834924;7759.068911730403;7803.336716379172;9177.908220917705;9328.160465558132;9346.532673366168;9418.4819834907;9574.856377154209;9568.76078098053;9711.805763884824;9770.804583908424;9869.11177993984;9962.551685174329;6730.730770769114;6837.555558888656;6947.68735406918;7437.851242975002;7556.168821429748;7595.5442673439775;8155.225253600898;8172.42793004484;8204.54874981858;8216.465929714788;6678.599284042973;7034.964825175842;7222.09723784527;7244.420446364173;7360.742374016883;7092.9645351772915;7112;7153.928460715534;7224.313690199423;7270.527415718173;7454.440916931143;7489.138749043712;7515.060617422822;7601.201873803171;7615.923840761743;6886;6891.517593768388;6937.167539895245;6938.375546200866;6950.54821436605;6973.023776671372;6977.755778547727;6991.40573051276;7026.473014524034;7029.0862187915245 11:51:20 INFO - PROCESS | 1940 | |4;prototype.html;323.26134782023075;327.3044779842834;331.1968476444622;335.97312215022816;340.1072185513028;6380.904286435702;6495.058216558602;6495.382938620835;6510.7395704171895;6514.3811337922825;6423.0686550450155;6423.935760642404;6435.710393032313;6462.903056454157;6465.094886715863;3575;4522.457305123382;4609.67732258742;4692.4369075710965;4732.881677958061;4660.114578230143;4731.503192164808;4741.170295198343;4742.834000809972;4757.976210118944;4303.483581970168;4674.3222232776225;4676.69601475903;4679.789409476564;4701.43582770068;4282.807273672693;4523.140603285382;4658.138244424792;4660.021395506914;4660.743659098748;4033.6369726724442;4036.0515278909434;4038.858639947617;4043.716939814214;4043.939340909889;5214.270002199657;6060.636361818305;6071.423214794588;6080.087986801971;6080.331163572004;5511.063119269734;5540.113581826929;5549.6115271930985;5555.777768889239;5562.0266453370905;5692.861427714473;5783.768649254025;6611.471082313404;6786.4570834333135;6797.388235058868;3841.8463261469506;4425.380446737459;4487;4606.378138951266;4615.861524154281;7018.122734658168;7111.3244241797465;7164.319389657974;7250.238724933859;7257.092863392023;4709.458412282563;4709.8351557696005;4714.198586240347;4723.4331880174595;4727.7163370197895;4792.376990991149;4803.1114243864995;4807.495213002584;4813.9037219255415;4817.108834865561;5662.320521537359;5668.914966275509;5669.376368599451;5670;5681.914771278434;6684.632345220963;6872.553284036521;6914.239433662293;6915.827104322432;6920.204176519765;1649.9422520211735;1668.4911102113972;1674.4558018643988;1679.5801049737565;1683.3434960365466;977.9119879210905;1020.9336393134571;1079.2391364088298;1085.5060947268973;1109.5506319940437;6074.42292982166;6215.782447614311;6377.107204991212;6382.776602818879;6386.2975072741965;7136.393406560397;7137.750178743719;7138.643067846587;7144.071270734771;7146.464015198881;6371.872562548723;6375.330590287953;6378.266499352541;6383.202099737533;6384.680765961683;3700.278445703062;3760.417135344026;3765.3787125124595;3765.7175711821174;3777.036855601859;7129.643517824088;7263.019492368463;7409.518381305198;7419.851602968019;7437.070366204224;6026.487748541335;6840.897386539206;6863.004864294649;7279.417646588367;7331.413486921034;7408;7414.961905333365;7429.294217049372;7435;7523.811904702427;6160.983437732903;6259.873222819936;6803.659817009228;6846.349596788297;7116.466265030247;6793.966030169818;6993.4754893384215;7042.753503627348;7054.294570542905;7057.470689698396;6071.848203794941;7387.1874093848555;7446.478746487694;7462.850742985219;7466.850662986819;4512.345709872116;4554.954450455453;4556.794944227584;4559.0881823634745;4567.771611419482;5821.621594596338;6985.860282794417;7044.295570442915;7064.823379415556;7076.787696369117;6545.901811472927;6773.017912402773;6786.355296246848;6839.863202736017;6845.897311540431;5572.498475137257;5624.85937851557;6293.615404610979;6796.2524122347495;6841.760538381132;6663.133792607124;6666.233383160805;6686.927052613705;6692;6692.0965669635925;6834.384905358542;6835.555688880207;6841.863162736817;6842.076319696777;6848.383645471732;6465.935340646722;6706.0611514389;6706.295838936841;6713.395794378529;6729.327067293231 11:51:20 INFO - PROCESS | 1940 | |5;yui.html;683.5420268420155;687.8727435424447;695.9512834101615;734.5409119300438;766.076877362778;12216.572419965303;17613.911930440347;17985.920844749326;17987.550311242227;18046.5488362791;16227.513174604752;16284.75572866408;16315.592110197222;16349.59126021847;16375.344986200567;728.355405466161;900.896396914355;915.3455279475174;915.6245939164944;917.0004694882576;728.0244472406973;910.4400793512009;925.0841666749936;929.0848514213494;929.8140371925608;935.8081593273363;969.4135048295785;980.7744218829673;982.0572250639394;986.4081551069373;761.9847603047964;934.2105920497169;956.636478138303;976.4434272464698;981.4700061966565;691.1153723234269;705.322890025576;718.120302629275;718.6909628859588;719.5071376107331;15303;15349.46276880315;15385.615359616098;15401.460948866736;15418.306176222097;12234.449449774693;12315.5073797048;12320.568780092743;12465.189762665488;12676.429560669792;9928.45393503357;10118.54466549007;10188.643397481053;10190;10537.789244215073;3441.105312618712;3478.2347883465595;3521.5950165731015;3522.876699315512;3568.91077723059;75485.6225718868;75531;75541.48917021629;75874.24125758727;79321.81017284746;9317.021712720203;9359.812803743887;9453.52732363379;9688.951555242178;9746.512674366253;21273.78726212749;21277.148914043573;21296.893515532633;21303.041363138695;21319.68020479663;7266.1280646322775;7311.232320606367;7373.3732632726815;7405.33351998312;7496.437767167485;4023.3562629979065;4053.7973101345406;4069.2471892699946;4070.61329173728;4123.752574845519;3559.928801423957;3611.8735844245325;3616.1140520572626;3619.8552057917914;3623.05800491874;463.0669201558862;469.14615399972405;608.8873558391712;614.708013693492;624.0545573456218;566.7506297229206;590.4577283696631;607.5109536822812;617.4837537036594;633.9461145802659;7595.240475952361;8021.719239826578;8039.919600803917;8062.596870156469;8203.958980205061;474.82668825878994;531.5989546210483;560.4759549820849;571.6541492397123;576.2364866551835;3132.37352529495;3524.136586536315;3739.7382183247455;3742.0270729610497;3935.409688546684;86565;87413;87535;87555;88306;78227.60886195532;78256.60871695605;78297.60851195708;79867.60066199748;80205;60579.394206057375;66308;67681.64636707336;67735.32264677389;68941.65529172322;7475.029964043061;7484.671714037483;7556.2443755624;7618.69525218985;7630.084389873251;46411.53588464072;46593.53406465892;46660.53339466698;47182.58452246438;47192.7640361796;55087.173692395445;62955;64306.678466607365;64702;65211.347886520525;9815.214782817215;10041.995800420193;10157.746056348355;10244.846327304947;10392.012758787903;10720.946395267974;10848.566057357617;11010.119190464584;11205.831912521482;11861.5848445304;6372.490200783834;10353;11310.377929213642;11398.715032124263;11806.940965295118;11219.158563107636;11221;11244.212905096565;11641.59254426091;11707.356095414834;11062.391568463812;11064.557417703201;11363.204575679954;11472.196946213686;11479.139064570358;9349.298802589969;9423.764405889908;9549.379290346105;9663.710088697351;9754.561044753145;8167.387445941459;9470.289728270269;9624.133827955518;9651;10004.649837255662 11:51:20 INFO - PROCESS | 1940 | __end_tp_report 11:51:20 INFO - PROCESS | 1940 | __start_cc_report 11:51:20 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,1338 11:51:20 INFO - PROCESS | 1940 | __end_cc_report 11:51:20 INFO - PROCESS | 1940 | __startTimestamp1460055080766__endTimestamp 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | ------- Summary: start ------- 11:51:20 INFO - PROCESS | 1940 | Number of tests: 6 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5681.85 Median:5833.91 stddev:619.22 (10.6%) stddev-sans-first:593.54 11:51:20 INFO - PROCESS | 1940 | Values: 3352.2 3354.6 3390.6 3396.5 3430.6 5552.3 5614.0 5627.8 5632.4 5637.6 5626.1 5722.8 5733.1 5770.5 5774.9 5081.5 5114.2 5135.4 5140.0 5163.1 5126.7 5212.5 5294.2 5301.1 5311.3 5076.0 5191.8 5216.4 5252.7 5269.6 5119.2 5131.1 5172.7 5194.4 5215.3 5076.6 5080.6 5085.9 5092.1 5128.8 5456.8 5522.6 5540.8 5558.3 5574.2 6095.9 6097.1 6127.8 6132.1 6139.1 5492.9 6242.3 6265.4 6274.8 6275.7 5632.3 5740.4 5747.7 5763.4 5765.8 6206.2 6261.2 6262.1 6273.7 6276.3 6010.9 6020.5 6044.5 6073.5 6079.3 6080.9 6173.6 6244.2 6249.7 6257.8 6051.9 6097.4 6109.0 6119.0 6146.8 6149.1 6150.4 6158.6 6163.8 6167.6 4846.1 4919.4 4925.1 4926.5 4953.5 4401.1 4426.4 4427.4 4471.3 4498.2 5563.4 5627.9 5630.3 5632.3 5639.5 6166.2 6183.9 6232.7 6247.4 6262.3 5642.0 5648.8 5658.9 5660.0 5689.2 5270.3 5376.9 5389.0 5397.9 5401.2 6246.0 6290.6 6312.8 6314.8 6320.7 6151.3 6194.0 6195.0 6204.8 6216.2 6212.8 6256.2 6289.0 6297.5 6302.0 6110.9 6147.6 6157.1 6158.7 6161.4 6174.8 6183.8 6189.4 6191.8 6200.3 5196.5 5931.1 5954.2 5964.5 6000.0 5745.4 5910.6 5929.7 5935.7 6005.5 5810.8 5834.1 5845.2 5861.1 5870.0 5975.1 5984.4 5986.8 5998.8 6056.0 5735.0 5800.2 5810.6 5833.9 5862.5 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:66011.98 Median:38901.71 stddev:143877.02 (369.8%) stddev-sans-first:144196.49 11:51:20 INFO - PROCESS | 1940 | Values: 474.9 524.6 567.0 642.4 648.0 37999.0 38532.8 38546.6 38561.2 38587.4 41723.6 42302.8 42349.4 42406.0 42452.0 9463.8 9689.9 9696.7 9713.0 9713.3 9448.2 9595.7 9602.3 9615.1 9626.0 9643.0 9660.9 9754.2 9759.0 9770.0 7937.1 9685.6 9721.4 9756.4 9992.6 9572.5 9707.7 9745.6 9758.5 9766.3 39697.8 40454.2 40737.6 41120.2 41149.8 3230.9 3408.3 3415.2 3448.2 3833.5 27447.3 28870.0 28916.0 28916.9 28973.6 2699.5 2842.4 2875.3 2880.6 2971.3 501842.0 502907.5 505530.0 505724.8 505879.0 65323.7 67467.7 67482.3 67532.6 67547.0 60039.0 71064.3 71093.3 71220.6 71430.6 15354.3 16923.6 17146.7 17156.8 17291.6 11504.3 11558.3 11564.0 11565.9 11581.4 15444.1 17638.9 20724.8 21340.1 21368.7 7658.0 8951.7 8968.1 9106.6 9109.5 808.7 861.7 932.8 1009.2 1012.2 25405.6 25590.7 26517.5 27652.9 27680.9 903.0 952.2 1071.4 1077.6 1117.1 13633.5 14025.4 15632.9 15682.3 16097.6 665969.0 673620.0 676598.0 676720.0 678538.0 50701.0 60868.1 60894.0 61042.7 61128.1 1343.5 1474.1 1494.0 1497.6 1601.7 27622.3 27660.7 28105.4 28171.7 28197.6 46173.8 46277.5 46931.3 46942.0 46974.5 394007.0 397242.0 397297.0 398531.0 398541.0 27573.0 27813.6 31461.0 32056.0 32591.3 38811.0 38992.4 39226.4 39731.8 39912.6 33204.8 34415.8 34856.5 34947.5 35183.5 33485.0 34066.8 34494.1 34726.3 34888.5 33929.5 34091.7 34283.8 34815.1 34970.8 29999.1 30202.5 30280.4 30288.7 30349.1 18732.3 19332.8 23100.4 23303.3 23566.0 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:33937.17 Median:353.76 stddev:97873.15 (27666.7%) stddev-sans-first:98115.20 11:51:20 INFO - PROCESS | 1940 | Values: 341.7 365.9 372.3 376.4 378.4 18847.5 19718.9 19776.9 20216.8 20251.0 19335.1 19941.7 20371.0 20629.5 20694.2 5531.7 5695.3 5709.1 5739.7 5763.9 4149.9 4190.5 4296.9 5625.4 5707.5 6299.1 6325.8 6339.7 6342.1 6344.3 6098.8 6219.8 6282.9 6317.5 6318.6 3685.6 3848.5 3854.1 5384.8 5413.8 24327.0 25273.0 25287.5 25426.0 25439.9 2239.3 2444.5 2629.9 2801.6 2880.1 13120.5 14255.4 14451.6 15246.3 15300.6 1739.1 1759.0 1794.1 1938.4 2095.5 79196.0 105441.5 107785.8 109337.0 116329.3 15988.4 17336.4 17781.0 18430.5 18862.9 29508.9 29511.3 29541.1 29569.0 29664.9 10511.4 10627.3 10652.8 10690.0 10748.6 7477.9 9053.9 9060.5 9150.0 9162.8 6641.0 8526.7 8529.5 8546.8 8633.6 2883.4 2941.0 3077.6 3148.8 3380.6 849.8 884.8 892.8 895.8 926.3 18828.5 18886.6 19109.5 19267.4 19656.6 819.8 841.1 927.8 937.7 948.2 9759.5 9853.6 9951.6 10031.5 10084.3 543401.0 563385.0 597822.0 622912.0 626921.0 103503.5 107612.5 110329.4 110358.9 110510.0 1010.3 1028.3 1049.8 1050.0 1051.1 14239.5 14400.7 16459.8 17074.8 17297.9 38268.0 47529.0 48327.0 48622.0 48976.5 67223.0 68687.0 69068.3 69132.3 69172.3 7606.3 7775.0 7838.5 7906.3 8136.7 7981.6 9219.1 9239.5 11475.7 11806.5 8860.4 9099.5 9554.2 10306.5 10422.8 8696.9 9847.6 10469.7 10560.3 10842.0 9928.5 9976.0 10412.3 10544.5 11029.8 7468.0 7635.9 7764.3 7930.6 7958.6 9839.2 10381.1 10513.8 10788.7 10818.7 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:6011.23 Median:5522.72 stddev:3122.65 (56.5%) stddev-sans-first:3111.76 11:51:20 INFO - PROCESS | 1940 | Values: 1351.2 1404.8 1629.7 1853.4 1967.7 7935.6 8526.8 8677.0 8677.3 8714.4 8393.0 8660.2 8683.9 8691.7 8734.3 2168.2 2433.4 2470.2 2491.5 2496.6 2494.9 2504.7 2506.5 2507.1 2509.6 2423.1 2475.1 2481.1 2482.5 2495.3 2421.9 2464.3 2478.2 2487.7 2488.0 2434.5 2469.2 2479.2 2490.0 2491.8 8758.1 8804.3 8810.4 8828.9 8851.8 5373.7 5516.6 5528.8 5576.4 5584.6 3485.2 3592.5 3642.7 3660.3 3664.7 917.6 1074.1 1076.9 1085.7 1086.4 11805.8 11813.3 11814.7 11826.5 11834.6 4806.7 4850.2 4919.4 4919.4 4929.0 10081.4 10095.7 10095.7 10100.4 10123.9 5533.3 5534.0 5537.6 5565.9 5572.2 4425.0 4558.0 4798.7 4952.8 4993.2 3862.8 3973.4 3976.4 3997.8 4016.1 1317.2 1323.3 1329.3 1338.8 1340.0 1306.4 1345.9 1358.7 1359.9 1386.0 8137.6 8187.8 8207.3 8224.9 8247.0 528.3 1256.5 1257.4 1316.5 1327.6 6194.3 6219.7 6295.6 6300.3 6307.9 10148.9 10477.2 10573.9 10593.0 10631.9 10169.6 10352.7 10438.4 10444.3 10478.9 8195.2 8289.2 8325.6 8405.4 8420.1 7644.9 7685.8 7735.8 7759.1 7803.3 9177.9 9328.2 9346.5 9418.5 9574.9 9568.8 9711.8 9770.8 9869.1 9962.6 6730.7 6837.6 6947.7 7437.9 7556.2 7595.5 8155.2 8172.4 8204.5 8216.5 6678.6 7035.0 7222.1 7244.4 7360.7 7093.0 7112.0 7153.9 7224.3 7270.5 7454.4 7489.1 7515.1 7601.2 7615.9 6886.0 6891.5 6937.2 6938.4 6950.5 6973.0 6977.8 6991.4 7026.5 7029.1 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:5562.20 Median:6332.74 stddev:1751.63 (27.7%) stddev-sans-first:1711.84 11:51:20 INFO - PROCESS | 1940 | Values: 323.3 327.3 331.2 336.0 340.1 6380.9 6495.1 6495.4 6510.7 6514.4 6423.1 6423.9 6435.7 6462.9 6465.1 3575.0 4522.5 4609.7 4692.4 4732.9 4660.1 4731.5 4741.2 4742.8 4758.0 4303.5 4674.3 4676.7 4679.8 4701.4 4282.8 4523.1 4658.1 4660.0 4660.7 4033.6 4036.1 4038.9 4043.7 4043.9 5214.3 6060.6 6071.4 6080.1 6080.3 5511.1 5540.1 5549.6 5555.8 5562.0 5692.9 5783.8 6611.5 6786.5 6797.4 3841.8 4425.4 4487.0 4606.4 4615.9 7018.1 7111.3 7164.3 7250.2 7257.1 4709.5 4709.8 4714.2 4723.4 4727.7 4792.4 4803.1 4807.5 4813.9 4817.1 5662.3 5668.9 5669.4 5670.0 5681.9 6684.6 6872.6 6914.2 6915.8 6920.2 1649.9 1668.5 1674.5 1679.6 1683.3 977.9 1020.9 1079.2 1085.5 1109.6 6074.4 6215.8 6377.1 6382.8 6386.3 7136.4 7137.8 7138.6 7144.1 7146.5 6371.9 6375.3 6378.3 6383.2 6384.7 3700.3 3760.4 3765.4 3765.7 3777.0 7129.6 7263.0 7409.5 7419.9 7437.1 6026.5 6840.9 6863.0 7279.4 7331.4 7408.0 7415.0 7429.3 7435.0 7523.8 6161.0 6259.9 6803.7 6846.3 7116.5 6794.0 6993.5 7042.8 7054.3 7057.5 6071.8 7387.2 7446.5 7462.9 7466.9 4512.3 4555.0 4556.8 4559.1 4567.8 5821.6 6985.9 7044.3 7064.8 7076.8 6545.9 6773.0 6786.4 6839.9 6845.9 5572.5 5624.9 6293.6 6796.3 6841.8 6663.1 6666.2 6686.9 6692.0 6692.1 6834.4 6835.6 6841.9 6842.1 6848.4 6465.9 6706.1 6706.3 6713.4 6729.3 11:51:20 INFO - PROCESS | 1940 | 11:51:20 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:17716.07 Median:611.80 stddev:24520.13 (4007.9%) stddev-sans-first:24555.56 11:51:20 INFO - PROCESS | 1940 | Values: 683.5 687.9 696.0 734.5 766.1 12216.6 17613.9 17985.9 17987.6 18046.5 16227.5 16284.8 16315.6 16349.6 16375.3 728.4 900.9 915.3 915.6 917.0 728.0 910.4 925.1 929.1 929.8 935.8 969.4 980.8 982.1 986.4 762.0 934.2 956.6 976.4 981.5 691.1 705.3 718.1 718.7 719.5 15303.0 15349.5 15385.6 15401.5 15418.3 12234.4 12315.5 12320.6 12465.2 12676.4 9928.5 10118.5 10188.6 10190.0 10537.8 3441.1 3478.2 3521.6 3522.9 3568.9 75485.6 75531.0 75541.5 75874.2 79321.8 9317.0 9359.8 9453.5 9689.0 9746.5 21273.8 21277.1 21296.9 21303.0 21319.7 7266.1 7311.2 7373.4 7405.3 7496.4 4023.4 4053.8 4069.2 4070.6 4123.8 3559.9 3611.9 3616.1 3619.9 3623.1 463.1 469.1 608.9 614.7 624.1 566.8 590.5 607.5 617.5 633.9 7595.2 8021.7 8039.9 8062.6 8204.0 474.8 531.6 560.5 571.7 576.2 3132.4 3524.1 3739.7 3742.0 3935.4 86565.0 87413.0 87535.0 87555.0 88306.0 78227.6 78256.6 78297.6 79867.6 80205.0 60579.4 66308.0 67681.6 67735.3 68941.7 7475.0 7484.7 7556.2 7618.7 7630.1 46411.5 46593.5 46660.5 47182.6 47192.8 55087.2 62955.0 64306.7 64702.0 65211.3 9815.2 10042.0 10157.7 10244.8 10392.0 10720.9 10848.6 11010.1 11205.8 11861.6 6372.5 10353.0 11310.4 11398.7 11806.9 11219.2 11221.0 11244.2 11641.6 11707.4 11062.4 11064.6 11363.2 11472.2 11479.1 9349.3 9423.8 9549.4 9663.7 9754.6 8167.4 9470.3 9624.1 9651.0 10004.6 11:51:20 INFO - PROCESS | 1940 | -------- Summary: end -------- 11:51:20 INFO - PROCESS | 1940 | 11:51:21 INFO - TEST-INFO | 1940: exit 0 11:51:21 INFO - TEST-OK | dromaeo_css | took 1113396ms 11:51:21 INFO - TEST-START | kraken 11:51:21 INFO - operating with platform_type : mac_ 11:51:21 INFO - Initialising browser for kraken test... 11:51:21 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxsclGs/profile http://localhost:49732/getInfo.html) 11:51:23 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 11:51:23 INFO - PROCESS | 1945 | colorDepth:24 11:51:23 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 11:51:23 INFO - PROCESS | 1945 | __metrics 11:51:23 INFO - PROCESS | 1945 | 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" 11:51:23 ERROR - PROCESS | 1945 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:51:24 INFO - TEST-INFO | 1945: exit 0 11:51:24 INFO - Browser initialized. 11:51:24 INFO - Running cycle 1/1 for kraken test... 11:51:24 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxsclGs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:36 INFO - PROCESS | 1947 | RSS: Main: 236998656 11:51:36 INFO - PROCESS | 1947 | 11:51:38 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49732/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:39 INFO - PROCESS | 1947 | RSS: Main: 283549696 11:51:39 INFO - PROCESS | 1947 | 11:51:42 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49732/tests/kraken/driver.html?testName=audio-dft) 11:51:42 INFO - PROCESS | 1947 | RSS: Main: 293785600 11:51:42 INFO - PROCESS | 1947 | 11:51:46 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49732/tests/kraken/driver.html?testName=audio-fft) 11:51:46 INFO - PROCESS | 1947 | RSS: Main: 279105536 11:51:46 INFO - PROCESS | 1947 | 11:51:48 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49732/tests/kraken/driver.html?testName=audio-oscillator) 11:51:49 INFO - PROCESS | 1947 | RSS: Main: 280961024 11:51:49 INFO - PROCESS | 1947 | 11:51:51 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:51 INFO - PROCESS | 1947 | RSS: Main: 281968640 11:51:51 INFO - PROCESS | 1947 | 11:51:54 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49732/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:55 INFO - PROCESS | 1947 | RSS: Main: 281931776 11:51:55 INFO - PROCESS | 1947 | 11:51:58 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49732/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:58 INFO - PROCESS | 1947 | RSS: Main: 283222016 11:51:58 INFO - PROCESS | 1947 | 11:52:01 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49732/tests/kraken/driver.html?testName=json-parse-financial) 11:52:02 INFO - PROCESS | 1947 | RSS: Main: 283512832 11:52:02 INFO - PROCESS | 1947 | 11:52:03 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:04 INFO - PROCESS | 1947 | RSS: Main: 318484480 11:52:04 INFO - PROCESS | 1947 | 11:52:06 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:06 INFO - PROCESS | 1947 | RSS: Main: 318050304 11:52:06 INFO - PROCESS | 1947 | 11:52:08 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:09 INFO - PROCESS | 1947 | RSS: Main: 323145728 11:52:09 INFO - PROCESS | 1947 | 11:52:12 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:12 INFO - PROCESS | 1947 | RSS: Main: 325582848 11:52:12 INFO - PROCESS | 1947 | 11:52:15 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:15 INFO - PROCESS | 1947 | RSS: Main: 325337088 11:52:15 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49732/tests/kraken/driver.html?testName=ai-astar) 11:52:17 INFO - PROCESS | 1947 | RSS: Main: 388419584 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | __start_tp_report 11:52:17 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 11:52:17 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 11:52:17 INFO - PROCESS | 1947 | |i|pagename|runs| 11:52:17 INFO - PROCESS | 1947 | |0;ai-astar;111;109;109;150;116;111;117;111;111;113 11:52:17 INFO - PROCESS | 1947 | |1;audio-beat-detection;160;125;143;154;117;163;168;146;171;118 11:52:17 INFO - PROCESS | 1947 | |2;audio-dft;185;183;185;187;185;185;184;179;189;253 11:52:17 INFO - PROCESS | 1947 | |3;audio-fft;74;75;85;79;55;71;57;79;83;54 11:52:17 INFO - PROCESS | 1947 | |4;audio-oscillator;92;99;129;71;62;79;135;113;114;122 11:52:17 INFO - PROCESS | 1947 | |5;imaging-gaussian-blur;116;125;85;83;86;82;86;83;88;84 11:52:17 INFO - PROCESS | 1947 | |6;imaging-darkroom;91;92;92;92;91;105;145;93;92;104 11:52:17 INFO - PROCESS | 1947 | |7;imaging-desaturate;85;89;88;85;85;85;86;87;87;86 11:52:17 INFO - PROCESS | 1947 | |8;json-parse-financial;55;55;54;52;54;51;53;66;52;50 11:52:17 INFO - PROCESS | 1947 | |9;json-stringify-tinderbox;63;69;69;71;72;61;65;65;66;67 11:52:17 INFO - PROCESS | 1947 | |10;stanford-crypto-aes;83;82;83;83;83;82;82;83;84;84 11:52:17 INFO - PROCESS | 1947 | |11;stanford-crypto-ccm;123;127;134;126;149;130;131;136;123;122 11:52:17 INFO - PROCESS | 1947 | |12;stanford-crypto-pbkdf2;139;130;141;138;135;124;137;143;175;174 11:52:17 INFO - PROCESS | 1947 | |13;stanford-crypto-sha256-iterative;70;67;66;66;66;67;68;91;94;93 11:52:17 INFO - PROCESS | 1947 | __end_tp_report 11:52:17 INFO - PROCESS | 1947 | __start_cc_report 11:52:17 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,1278 11:52:17 INFO - PROCESS | 1947 | __end_cc_report 11:52:17 INFO - PROCESS | 1947 | __startTimestamp1460055137895__endTimestamp 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | ------- Summary: start ------- 11:52:17 INFO - PROCESS | 1947 | Number of tests: 14 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#0] ai-astar Cycles:10 Average:115.80 Median:112.00 stddev:12.31 (11.0%) stddev-sans-first:12.93 11:52:17 INFO - PROCESS | 1947 | Values: 111.0 109.0 109.0 150.0 116.0 111.0 117.0 111.0 111.0 113.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:157.00 stddev:20.36 (13.0%) stddev-sans-first:21.00 11:52:17 INFO - PROCESS | 1947 | Values: 160.0 125.0 143.0 154.0 117.0 163.0 168.0 146.0 171.0 118.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#2] audio-dft Cycles:10 Average:191.50 Median:185.00 stddev:21.76 (11.8%) stddev-sans-first:22.96 11:52:17 INFO - PROCESS | 1947 | Values: 185.0 183.0 185.0 187.0 185.0 185.0 184.0 179.0 189.0 253.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#3] audio-fft Cycles:10 Average:71.20 Median:77.00 stddev:11.71 (15.2%) stddev-sans-first:12.37 11:52:17 INFO - PROCESS | 1947 | Values: 74.0 75.0 85.0 79.0 55.0 71.0 57.0 79.0 83.0 54.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:66.50 stddev:25.12 (37.8%) stddev-sans-first:26.41 11:52:17 INFO - PROCESS | 1947 | Values: 92.0 99.0 129.0 71.0 62.0 79.0 135.0 113.0 114.0 122.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:84.50 stddev:15.38 (18.2%) stddev-sans-first:13.59 11:52:17 INFO - PROCESS | 1947 | Values: 116.0 125.0 85.0 83.0 86.0 82.0 86.0 83.0 88.0 84.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:92.00 stddev:16.77 (18.2%) stddev-sans-first:17.49 11:52:17 INFO - PROCESS | 1947 | Values: 91.0 92.0 92.0 92.0 91.0 105.0 145.0 93.0 92.0 104.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.42 (1.6%) stddev-sans-first:1.42 11:52:17 INFO - PROCESS | 1947 | Values: 85.0 89.0 88.0 85.0 85.0 85.0 86.0 87.0 87.0 86.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:4.47 (8.3%) stddev-sans-first:4.73 11:52:17 INFO - PROCESS | 1947 | Values: 55.0 55.0 54.0 52.0 54.0 51.0 53.0 66.0 52.0 50.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:68.00 stddev:3.49 (5.1%) stddev-sans-first:3.42 11:52:17 INFO - PROCESS | 1947 | Values: 63.0 69.0 69.0 71.0 72.0 61.0 65.0 65.0 66.0 67.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 11:52:17 INFO - PROCESS | 1947 | Values: 83.0 82.0 83.0 83.0 83.0 82.0 82.0 83.0 84.0 84.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.50 stddev:8.17 (6.3%) stddev-sans-first:8.25 11:52:17 INFO - PROCESS | 1947 | Values: 123.0 127.0 134.0 126.0 149.0 130.0 131.0 136.0 123.0 122.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:140.00 stddev:17.18 (12.3%) stddev-sans-first:18.14 11:52:17 INFO - PROCESS | 1947 | Values: 139.0 130.0 141.0 138.0 135.0 124.0 137.0 143.0 175.0 174.0 11:52:17 INFO - PROCESS | 1947 | 11:52:17 INFO - PROCESS | 1947 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:69.00 stddev:12.41 (18.0%) stddev-sans-first:13.04 11:52:17 INFO - PROCESS | 1947 | Values: 70.0 67.0 66.0 66.0 66.0 67.0 68.0 91.0 94.0 93.0 11:52:17 INFO - PROCESS | 1947 | -------- Summary: end -------- 11:52:17 INFO - PROCESS | 1947 | 11:52:18 INFO - TEST-INFO | 1947: exit 0 11:52:18 INFO - TEST-OK | kraken | took 57289ms 11:52:18 INFO - SUITE-END | took 1170s 11:52:19 INFO - Completed test suite (00:19:31) 11:52:19 INFO - javascript benchmark 11:52:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.195473086459, 3354.5974483062023, 3390.627031026587, 3396.5414669019674, 3430.6397828228037, 5552.278203833496, 5613.971930140354, 5627.77488900444, 5632.35227948785, 5637.577181711378, 5626.099824028156, 5722.771089156428, 5733.111367737997, 5770.4518070783315, 5774.913376299359, 5081.46644602317, 5114.156164232897, 5135.383753949532, 5140.0, 5163.096458119833, 5126.666766660173, 5212.5308722214995, 5294.179402192666, 5301.125314323132, 5311.336082989626, 5075.98480303937, 5191.792328306863, 5216.400113986902, 5252.684838909678, 5269.604779641523, 5119.206522988943, 5131.076406246874, 5172.663776854492, 5194.428612852583, 5215.322008138917, 5076.6192535559985, 5080.568151707109, 5085.949140508585, 5092.11157289003, 5128.8461346159675, 5456.781728730846, 5522.641028333145, 5540.750666220029, 5558.277423934863, 5574.247476590649, 6095.908561371583, 6097.146399504073, 6127.78552750656, 6132.110843927606, 6139.093519790236, 5492.917606235909, 6242.313345531988, 6265.404786545271, 6274.780382686629, 6275.717592708339, 5632.324121105412, 5740.397258287861, 5747.683877386742, 5763.366029736726, 5765.798197063166, 6206.224221972254, 6261.24865016201, 6262.060690896402, 6273.7176827042895, 6276.309605943343, 6010.939890601126, 6020.488258497989, 6044.486218671462, 6073.453389194994, 6079.300880398722, 6080.878382432326, 6173.59871608344, 6244.1570387997035, 6249.7187626556915, 6257.812265632038, 6051.878962420727, 6097.433938678448, 6108.969455152695, 6118.979605063136, 6146.801373732169, 6149.0776383542825, 6150.446459818638, 6158.630482171084, 6163.84590385244, 6167.599106058182, 4846.103470857903, 4919.36048313724, 4925.064237794808, 4926.45808961014, 4953.529414705597, 4401.075774087413, 4426.380306757057, 4427.424434823452, 4471.306947423154, 4498.190325741398, 5563.36021357541, 5627.859303517363, 5630.268065151504, 5632.2678051853, 5639.492445679826, 6166.229221347332, 6183.907241391383, 6232.657203853741, 6247.406496382836, 6262.3111457739615, 5642.0, 5648.774049038075, 5658.915116273177, 5659.971700141473, 5689.231953686282, 5270.341207349082, 5376.946230537645, 5389.0, 5397.9460205397445, 5401.243825864382, 6245.96877015612, 6290.591111577733, 6312.810615681537, 6314.778982735582, 6320.71556779946, 6151.292601350723, 6194.0, 6195.008798592204, 6204.844878877883, 6216.160818289473, 6212.844678883064, 6256.249250090018, 6289.0, 6297.527685423704, 6301.96849015752, 6110.908336375047, 6147.569670123048, 6157.076438534255, 6158.661273629814, 6161.353057928853, 6174.753009879734, 6183.81448556544, 6189.381061893775, 6191.783287584913, 6200.286966998853, 5196.480351964925, 5931.13998470228, 5954.166416701579, 5964.493018093511, 5999.980003399345, 5745.368009519033, 5910.645361278337, 5929.703514824155, 5935.732892019783, 6005.549583781147, 5810.767569297181, 5834.066549352084, 5845.240118784531, 5861.0915308127305, 5870.0, 5975.073863551156, 5984.401559843981, 5986.760529578768, 5998.760049597967, 6056.0, 5735.0, 5800.216970708901, 5810.593258471867, 5833.912491312549, 5862.472377486047], "value": 5642.9722496580425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.94562072199705, 524.5908191610542, 566.9773209071637, 642.4442856928756, 647.9870402591948, 37999.0, 38532.80733596331, 38546.614533854656, 38561.228775424475, 38587.42118868216, 41723.58276417235, 42302.7884860576, 42349.36475952855, 42406.0, 42452.0, 9463.81072378552, 9689.903100969006, 9696.660616878411, 9712.951435242814, 9713.271504637145, 9448.196903263231, 9595.712128636153, 9602.327837051409, 9615.13463788259, 9625.951870240639, 9642.987486313941, 9660.855087173699, 9754.219662427024, 9758.951205243964, 9770.022997700244, 7937.126916039231, 9685.564149613285, 9721.368111072758, 9756.414615123116, 9992.550335234931, 9572.47351395673, 9707.66023189185, 9745.610175592969, 9758.463284519348, 9766.267529935283, 39697.80151099226, 40454.190916181804, 40737.59262407367, 41120.1775964479, 41149.79425102855, 3230.91922701932, 3408.3353746019534, 3415.197428604276, 3448.2241495663525, 3833.5208098987628, 27447.313817154532, 28870.0, 28916.0, 28916.855415722996, 28973.56539651907, 2699.5140874642557, 2842.3888863894363, 2875.3099256178366, 2880.6111174991315, 2971.257185703574, 501842.0, 502907.485462574, 505530.0, 505724.7710091592, 505879.0, 65323.67338163279, 67467.66266168638, 67482.32517674859, 67532.64934701279, 67547.0, 60039.0, 71064.28935710576, 71093.28906710866, 71220.64389678121, 71430.64284678648, 15354.309056092503, 16923.57691057709, 17146.657066858843, 17156.828431715774, 17291.567710807078, 11504.25222360544, 11558.30650160993, 11564.017058549949, 11565.942170289263, 11581.420928953687, 15444.091755376858, 17638.883334000002, 20724.792752072288, 21340.14639414406, 21368.679469807965, 7658.0, 8951.686690965915, 8968.148025937526, 9106.590203440861, 9109.498977556297, 808.6563210635456, 861.7414775567305, 932.7574830543972, 1009.1573536097441, 1012.1801340913884, 25405.61891571628, 25590.74409255921, 26517.46388411078, 27652.861735691193, 27680.86159569189, 902.9864552031725, 952.1716106986966, 1071.4267866691282, 1077.5635867473686, 1117.07841031148, 13633.522826701217, 14025.368858401396, 15632.92183539075, 15682.294296756674, 16097.597560061093, 665969.0, 673620.0, 676598.0, 676720.0, 678538.0, 50701.0, 60868.086978695355, 60894.0, 61042.69478652578, 61128.08307875385, 1343.4693296148162, 1474.0860666386695, 1493.992530037343, 1497.6405662641105, 1601.7277062899336, 27622.3094422633, 27660.72339276662, 28105.43789124247, 28171.71828281691, 28197.577036344883, 46173.76913115413, 46277.53722462867, 46931.296030558886, 46942.0, 46974.53025469701, 394007.0, 397242.0, 397297.0, 398531.0, 398541.0, 27573.0, 27813.582796258477, 31461.0, 32056.0, 32591.34817303688, 38811.0, 38992.41511377388, 39226.41160382539, 39731.801340994265, 39912.60087399089, 33204.83397582997, 34415.82792086023, 34856.47715284222, 34947.47578786371, 35183.47224791681, 33485.0, 34066.82966585151, 34494.13764655904, 34726.30547388987, 34888.47667284942, 33929.49105763465, 34091.65908340984, 34283.828580856934, 34815.12962175966, 34970.82514587411, 29999.100026999226, 30202.54696179603, 30280.394392112474, 30288.69711302859, 30349.089527314216, 18732.25070997145, 19332.806671933664, 23100.422489437897, 23303.300900972998, 23566.0], "value": 19439.01459696299, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6651681352273, 365.85183000884643, 372.30379190913, 376.4052796581401, 378.38134649847507, 18847.528811779695, 19718.915459649714, 19776.90111549442, 20216.797832021675, 20250.987450627483, 19335.12991915364, 19941.700874486894, 20370.981450927433, 20629.484262893435, 20694.172233110694, 5531.723413829312, 5695.259616249882, 5709.115087161496, 5739.655620662774, 5763.942360576403, 4149.896252593694, 4190.51809041961, 4296.935545966813, 5625.437456254363, 5707.4577915098, 6299.055141728754, 6325.810225693213, 6339.71471283791, 6342.143810585558, 6344.302126766052, 6098.756049758004, 6219.844503887393, 6282.937170628281, 6317.526185536057, 6318.620882747027, 3685.5761587417255, 3848.461215429842, 3854.094287842355, 5384.757685904144, 5413.783448662049, 24327.0, 25273.0, 25287.49425011508, 25426.0, 25439.87280063588, 2239.3058151972778, 2444.5477586646525, 2629.9348763750713, 2801.607774911514, 2880.0783749200264, 13120.47518099275, 14255.429782808675, 14451.566453006426, 15246.313915873701, 15300.617484562863, 1739.0956702514623, 1758.9824101758948, 1794.1477798045955, 1938.4281636917003, 2095.518030852897, 79196.0, 105441.47279263631, 107785.84428311468, 109337.0, 116329.25506117415, 15988.36046558148, 17336.39322623702, 17781.0, 18430.539236519195, 18862.90568547176, 29508.852455738015, 29511.26221844471, 29541.113766586608, 29569.0, 29664.851675741917, 10511.421871796972, 10627.256092073636, 10652.833375812725, 10690.0, 10748.623798167027, 7477.887831682529, 9053.909460905306, 9060.54697265134, 9150.0, 9162.770930726785, 6641.0, 8526.658933642584, 8529.530875801767, 8546.78633034179, 8633.611487483078, 2883.423315336941, 2940.9852950735108, 3077.584526088994, 3148.8349310755166, 3380.61064587929, 849.7748096754365, 884.7566919097171, 892.7544925145637, 895.7760559859904, 926.346925417579, 18828.529286767665, 18886.622267554845, 19109.522261943563, 19267.421977340422, 19656.606867862847, 819.8476856486799, 841.1242928269992, 927.7634203278121, 937.6671281695036, 948.2177203806887, 9759.463229522444, 9853.556589953469, 9951.55218015191, 10031.548580313904, 10084.344517606332, 543401.0, 563385.0, 597822.0, 622912.0, 626921.0, 103503.4824825871, 107612.4619376898, 110329.44835275772, 110358.89641103646, 110510.0, 1010.3483253301727, 1028.3367228137809, 1049.7797159008642, 1050.0182329521922, 1051.106559424483, 14239.50161744334, 14400.711985760436, 16459.84781065314, 17074.829251707324, 17297.875638083988, 38268.04329891775, 47529.0, 48327.03345933132, 48622.02755944932, 48976.51023489719, 67223.0, 68686.9696954536, 69068.30931690619, 69132.30867691258, 69172.27069323308, 7606.315431611181, 7774.961125194338, 7838.451308408356, 7906.327962123284, 8136.674533018613, 7981.640826162953, 9219.124183202584, 9239.491827949527, 11475.713107172387, 11806.527738890692, 8860.424072435271, 9099.528904503237, 9554.187894028808, 10306.48467576633, 10422.843657344994, 8696.91303086961, 9847.553356325228, 10469.738256543647, 10560.260781745512, 10841.970012848768, 9928.503574821374, 9975.950120249352, 10412.32319899204, 10544.472776360997, 11029.779404412027, 7467.962660186664, 7635.923640763744, 7764.262395072459, 7930.603469826601, 7958.602069896598, 9839.212862971088, 10381.11760500366, 10513.842292365774, 10788.730281743019, 10818.67543973682], "value": 9819.122539542612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.2230467481202, 1404.8314202295724, 1629.7066528024955, 1853.4254381141848, 1967.7048442733587, 7935.563544005077, 8526.786830329245, 8677.0, 8677.305815534757, 8714.433561818492, 8393.0, 8660.220580147785, 8683.91316086839, 8691.73924782256, 8734.257588105018, 2168.2194410012385, 2433.4159801647565, 2470.1848390031246, 2491.451880586277, 2496.6130249811217, 2494.900203991838, 2504.7370026147264, 2506.4611108611643, 2507.147569826259, 2509.648649189115, 2423.0671191591277, 2475.096589744739, 2481.081999660128, 2482.515909397668, 2495.338735235155, 2421.8738286696685, 2464.322311364371, 2478.157426475007, 2487.664165337674, 2488.0, 2434.500927309915, 2469.1604854349607, 2479.194261864883, 2489.987550062256, 2491.775740183374, 8758.124187581254, 8804.295656347476, 8810.38327317088, 8828.8675669865, 8851.77870553235, 5373.650712703701, 5516.613837031409, 5528.834134975917, 5576.442355764431, 5584.553235741131, 3485.233248685285, 3592.5329707137903, 3642.7085833133287, 3660.3411385950517, 3664.706823454117, 917.6008436330218, 1074.097757883374, 1076.8546246256733, 1085.7339951711801, 1086.3916206924148, 11805.822912656316, 11813.29120252779, 11814.704632384173, 11826.526938922432, 11834.585789497327, 4806.663533552688, 4850.175470170009, 4919.385076865392, 4919.409670839522, 4929.014197160583, 10081.445520496443, 10095.697129086138, 10095.697129086138, 10100.444475553768, 10123.949380253052, 5533.335999679984, 5534.0315444797, 5537.58468114893, 5565.916511252334, 5572.164175373727, 4424.977875110604, 4557.95442045582, 4798.736069516141, 4952.826651067267, 4993.17612593918, 3862.845486180521, 3973.3642617181113, 3976.4035394691027, 3997.800109994547, 4016.0562267867026, 1317.2228385252556, 1323.3052647360214, 1329.2888304757103, 1338.8326459192601, 1340.0418700629098, 1306.399056434051, 1345.8855997240148, 1358.721462100267, 1359.8776110150134, 1385.9792103118461, 8137.552434616035, 8187.754367368989, 8207.343412526983, 8224.876626850602, 8246.958765206256, 528.2762615217177, 1256.4848412150975, 1257.3964497041472, 1316.5260506217753, 1327.5751759436887, 6194.318624951252, 6219.689015549205, 6295.590786598948, 6300.338464461257, 6307.896118179392, 10148.898511014942, 10477.21420893436, 10573.9471302643, 10593.046625803714, 10631.94684026575, 10169.593216271414, 10352.741181470523, 10438.37369757817, 10444.268901176996, 10478.947605262078, 8195.180481951877, 8289.171082891784, 8325.583720814057, 8405.411621186458, 8420.073791882887, 7644.923550764644, 7685.807854803675, 7735.806604834924, 7759.068911730403, 7803.336716379172, 9177.908220917705, 9328.160465558132, 9346.532673366168, 9418.4819834907, 9574.856377154209, 9568.76078098053, 9711.805763884824, 9770.804583908424, 9869.11177993984, 9962.551685174329, 6730.730770769114, 6837.555558888656, 6947.68735406918, 7437.851242975002, 7556.168821429748, 7595.5442673439775, 8155.225253600898, 8172.42793004484, 8204.54874981858, 8216.465929714788, 6678.599284042973, 7034.964825175842, 7222.09723784527, 7244.420446364173, 7360.742374016883, 7092.9645351772915, 7112.0, 7153.928460715534, 7224.313690199423, 7270.527415718173, 7454.440916931143, 7489.138749043712, 7515.060617422822, 7601.201873803171, 7615.923840761743, 6886.0, 6891.517593768388, 6937.167539895245, 6938.375546200866, 6950.54821436605, 6973.023776671372, 6977.755778547727, 6991.40573051276, 7026.473014524034, 7029.0862187915245], "value": 4931.276871648391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.26134782023075, 327.3044779842834, 331.1968476444622, 335.97312215022816, 340.1072185513028, 6380.904286435702, 6495.058216558602, 6495.382938620835, 6510.7395704171895, 6514.3811337922825, 6423.0686550450155, 6423.935760642404, 6435.710393032313, 6462.903056454157, 6465.094886715863, 3575.0, 4522.457305123382, 4609.67732258742, 4692.4369075710965, 4732.881677958061, 4660.114578230143, 4731.503192164808, 4741.170295198343, 4742.834000809972, 4757.976210118944, 4303.483581970168, 4674.3222232776225, 4676.69601475903, 4679.789409476564, 4701.43582770068, 4282.807273672693, 4523.140603285382, 4658.138244424792, 4660.021395506914, 4660.743659098748, 4033.6369726724442, 4036.0515278909434, 4038.858639947617, 4043.716939814214, 4043.939340909889, 5214.270002199657, 6060.636361818305, 6071.423214794588, 6080.087986801971, 6080.331163572004, 5511.063119269734, 5540.113581826929, 5549.6115271930985, 5555.777768889239, 5562.0266453370905, 5692.861427714473, 5783.768649254025, 6611.471082313404, 6786.4570834333135, 6797.388235058868, 3841.8463261469506, 4425.380446737459, 4487.0, 4606.378138951266, 4615.861524154281, 7018.122734658168, 7111.3244241797465, 7164.319389657974, 7250.238724933859, 7257.092863392023, 4709.458412282563, 4709.8351557696005, 4714.198586240347, 4723.4331880174595, 4727.7163370197895, 4792.376990991149, 4803.1114243864995, 4807.495213002584, 4813.9037219255415, 4817.108834865561, 5662.320521537359, 5668.914966275509, 5669.376368599451, 5670.0, 5681.914771278434, 6684.632345220963, 6872.553284036521, 6914.239433662293, 6915.827104322432, 6920.204176519765, 1649.9422520211735, 1668.4911102113972, 1674.4558018643988, 1679.5801049737565, 1683.3434960365466, 977.9119879210905, 1020.9336393134571, 1079.2391364088298, 1085.5060947268973, 1109.5506319940437, 6074.42292982166, 6215.782447614311, 6377.107204991212, 6382.776602818879, 6386.2975072741965, 7136.393406560397, 7137.750178743719, 7138.643067846587, 7144.071270734771, 7146.464015198881, 6371.872562548723, 6375.330590287953, 6378.266499352541, 6383.202099737533, 6384.680765961683, 3700.278445703062, 3760.417135344026, 3765.3787125124595, 3765.7175711821174, 3777.036855601859, 7129.643517824088, 7263.019492368463, 7409.518381305198, 7419.851602968019, 7437.070366204224, 6026.487748541335, 6840.897386539206, 6863.004864294649, 7279.417646588367, 7331.413486921034, 7408.0, 7414.961905333365, 7429.294217049372, 7435.0, 7523.811904702427, 6160.983437732903, 6259.873222819936, 6803.659817009228, 6846.349596788297, 7116.466265030247, 6793.966030169818, 6993.4754893384215, 7042.753503627348, 7054.294570542905, 7057.470689698396, 6071.848203794941, 7387.1874093848555, 7446.478746487694, 7462.850742985219, 7466.850662986819, 4512.345709872116, 4554.954450455453, 4556.794944227584, 4559.0881823634745, 4567.771611419482, 5821.621594596338, 6985.860282794417, 7044.295570442915, 7064.823379415556, 7076.787696369117, 6545.901811472927, 6773.017912402773, 6786.355296246848, 6839.863202736017, 6845.897311540431, 5572.498475137257, 5624.85937851557, 6293.615404610979, 6796.2524122347495, 6841.760538381132, 6663.133792607124, 6666.233383160805, 6686.927052613705, 6692.0, 6692.0965669635925, 6834.384905358542, 6835.555688880207, 6841.863162736817, 6842.076319696777, 6848.383645471732, 6465.935340646722, 6706.0611514389, 6706.295838936841, 6713.395794378529, 6729.327067293231], "value": 4987.094839532574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.5420268420155, 687.8727435424447, 695.9512834101615, 734.5409119300438, 766.076877362778, 12216.572419965303, 17613.911930440347, 17985.920844749326, 17987.550311242227, 18046.5488362791, 16227.513174604752, 16284.75572866408, 16315.592110197222, 16349.59126021847, 16375.344986200567, 728.355405466161, 900.896396914355, 915.3455279475174, 915.6245939164944, 917.0004694882576, 728.0244472406973, 910.4400793512009, 925.0841666749936, 929.0848514213494, 929.8140371925608, 935.8081593273363, 969.4135048295785, 980.7744218829673, 982.0572250639394, 986.4081551069373, 761.9847603047964, 934.2105920497169, 956.636478138303, 976.4434272464698, 981.4700061966565, 691.1153723234269, 705.322890025576, 718.120302629275, 718.6909628859588, 719.5071376107331, 15303.0, 15349.46276880315, 15385.615359616098, 15401.460948866736, 15418.306176222097, 12234.449449774693, 12315.5073797048, 12320.568780092743, 12465.189762665488, 12676.429560669792, 9928.45393503357, 10118.54466549007, 10188.643397481053, 10190.0, 10537.789244215073, 3441.105312618712, 3478.2347883465595, 3521.5950165731015, 3522.876699315512, 3568.91077723059, 75485.6225718868, 75531.0, 75541.48917021629, 75874.24125758727, 79321.81017284746, 9317.021712720203, 9359.812803743887, 9453.52732363379, 9688.951555242178, 9746.512674366253, 21273.78726212749, 21277.148914043573, 21296.893515532633, 21303.041363138695, 21319.68020479663, 7266.1280646322775, 7311.232320606367, 7373.3732632726815, 7405.33351998312, 7496.437767167485, 4023.3562629979065, 4053.7973101345406, 4069.2471892699946, 4070.61329173728, 4123.752574845519, 3559.928801423957, 3611.8735844245325, 3616.1140520572626, 3619.8552057917914, 3623.05800491874, 463.0669201558862, 469.14615399972405, 608.8873558391712, 614.708013693492, 624.0545573456218, 566.7506297229206, 590.4577283696631, 607.5109536822812, 617.4837537036594, 633.9461145802659, 7595.240475952361, 8021.719239826578, 8039.919600803917, 8062.596870156469, 8203.958980205061, 474.82668825878994, 531.5989546210483, 560.4759549820849, 571.6541492397123, 576.2364866551835, 3132.37352529495, 3524.136586536315, 3739.7382183247455, 3742.0270729610497, 3935.409688546684, 86565.0, 87413.0, 87535.0, 87555.0, 88306.0, 78227.60886195532, 78256.60871695605, 78297.60851195708, 79867.60066199748, 80205.0, 60579.394206057375, 66308.0, 67681.64636707336, 67735.32264677389, 68941.65529172322, 7475.029964043061, 7484.671714037483, 7556.2443755624, 7618.69525218985, 7630.084389873251, 46411.53588464072, 46593.53406465892, 46660.53339466698, 47182.58452246438, 47192.7640361796, 55087.173692395445, 62955.0, 64306.678466607365, 64702.0, 65211.347886520525, 9815.214782817215, 10041.995800420193, 10157.746056348355, 10244.846327304947, 10392.012758787903, 10720.946395267974, 10848.566057357617, 11010.119190464584, 11205.831912521482, 11861.5848445304, 6372.490200783834, 10353.0, 11310.377929213642, 11398.715032124263, 11806.940965295118, 11219.158563107636, 11221.0, 11244.212905096565, 11641.59254426091, 11707.356095414834, 11062.391568463812, 11064.557417703201, 11363.204575679954, 11472.196946213686, 11479.139064570358, 9349.298802589969, 9423.764405889908, 9549.379290346105, 9663.710088697351, 9754.561044753145, 8167.387445941459, 9470.289728270269, 9624.133827955518, 9651.0, 10004.649837255662], "value": 6766.870321263869, "unit": "score"}], "name": "dromaeo_css", "value": 7508.979594799963, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 109.0, 150.0, 116.0, 111.0, 117.0, 111.0, 111.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 143.0, 154.0, 117.0, 163.0, 168.0, 146.0, 171.0, 118.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 187.0, 185.0, 185.0, 184.0, 179.0, 189.0, 253.0], "value": 191.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 85.0, 79.0, 55.0, 71.0, 57.0, 79.0, 83.0, 54.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 99.0, 129.0, 71.0, 62.0, 79.0, 135.0, 113.0, 114.0, 122.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 125.0, 85.0, 83.0, 86.0, 82.0, 86.0, 83.0, 88.0, 84.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 92.0, 91.0, 105.0, 145.0, 93.0, 92.0, 104.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 88.0, 85.0, 85.0, 85.0, 86.0, 87.0, 87.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 52.0, 54.0, 51.0, 53.0, 66.0, 52.0, 50.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 69.0, 71.0, 72.0, 61.0, 65.0, 65.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 83.0, 82.0, 82.0, 83.0, 84.0, 84.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 134.0, 126.0, 149.0, 130.0, 131.0, 136.0, 123.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 141.0, 138.0, 135.0, 124.0, 137.0, 143.0, 175.0, 174.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 66.0, 66.0, 66.0, 67.0, 68.0, 91.0, 94.0, 93.0], "value": 74.8, "unit": "score"}], "name": "kraken", "value": 1456.8, "alertThreshold": 2.0}]} 11:52:19 INFO - Return code: 0 11:52:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:52:19 ERROR - # TBPL SUCCESS # 11:52:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:52:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:52:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:52:19 INFO - 2016-04-07 11:52:19.169 screenresolution[1951:13698] starting screenresolution argv=screenresolution get 11:52:19 INFO - 2016-04-07 11:52:19.172 screenresolution[1951:13698] Display 0: 1600x1200x32@60 11:52:19 INFO - 2016-04-07 11:52:19.178 screenresolution[1952:13701] starting screenresolution argv=screenresolution list 11:52:19 INFO - Available Modes on Display 0 11:52:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:52:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:52:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:52:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:52:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:52:19 INFO - Intel Iris: 11:52:19 INFO - Chipset Model: Intel Iris 11:52:19 INFO - Type: GPU 11:52:19 INFO - Bus: Built-In 11:52:19 INFO - VRAM (Dynamic, Max): 1536 MB 11:52:19 INFO - Vendor: Intel (0x8086) 11:52:19 INFO - Device ID: 0x0a2e 11:52:19 INFO - Revision ID: 0x0009 11:52:19 INFO - Displays: 11:52:19 INFO - Display: 11:52:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:52:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:52:19 INFO - Display Serial Number: 1600x1200 60 11:52:19 INFO - Main Display: Yes 11:52:19 INFO - Mirror: Off 11:52:19 INFO - Online: Yes 11:52:19 INFO - Rotation: Supported 11:52:19 INFO - Return code: 0 11:52:19 INFO - Running post-action listener: _resource_record_post_action 11:52:19 INFO - Running post-run listener: _resource_record_post_run 11:52:20 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 606208; Write bytes: 693086208; Read time: 11; Write time: 1851 11:52:20 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 383848960; Write bytes: 378111488; Read time: 28027; Write time: 671 11:52:20 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 606208; Write bytes: 297447936; Read time: 11; Write time: 1141 11:52:20 INFO - Running post-run listener: _upload_blobber_files 11:52:20 INFO - Blob upload gear active. 11:52:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:52:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:21 INFO - (blobuploader) - INFO - Done attempting. 11:52:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:22 INFO - (blobuploader) - INFO - Done attempting. 11:52:22 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:22 INFO - Return code: 0 11:52:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ee9b4274731d3a1362847f38f6a9d1e98e82eccecf1948853b3d5997eb81ed042dbb50ee4b4d3f20aa646f213c41dca2d728f86967954533b80e743c25a0868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b7896f7cb9cef9599e0dd59afcd7071da727f7b492e1b50e1d5b14f97671811292c3255a7f16a118c85e60fd50f11e68c02e02358ee9ed40f622317942ce38b"} 11:52:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:22 INFO - Contents: 11:52:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ee9b4274731d3a1362847f38f6a9d1e98e82eccecf1948853b3d5997eb81ed042dbb50ee4b4d3f20aa646f213c41dca2d728f86967954533b80e743c25a0868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b7896f7cb9cef9599e0dd59afcd7071da727f7b492e1b50e1d5b14f97671811292c3255a7f16a118c85e60fd50f11e68c02e02358ee9ed40f622317942ce38b"} 11:52:22 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:22 INFO - Copying logs to upload dir... 11:52:22 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.897317 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-07 11:52:22.825095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 11:52:22.828314) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/1ee9b4274731d3a1362847f38f6a9d1e98e82eccecf1948853b3d5997eb81ed042dbb50ee4b4d3f20aa646f213c41dca2d728f86967954533b80e743c25a0868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b7896f7cb9cef9599e0dd59afcd7071da727f7b492e1b50e1d5b14f97671811292c3255a7f16a118c85e60fd50f11e68c02e02358ee9ed40f622317942ce38b"} build_url:https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/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/1ee9b4274731d3a1362847f38f6a9d1e98e82eccecf1948853b3d5997eb81ed042dbb50ee4b4d3f20aa646f213c41dca2d728f86967954533b80e743c25a0868", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b7896f7cb9cef9599e0dd59afcd7071da727f7b492e1b50e1d5b14f97671811292c3255a7f16a118c85e60fd50f11e68c02e02358ee9ed40f622317942ce38b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 11:52:22.855632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:52:22.856064) ========= 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.weePXGYQ7j/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.K7XJBI3egZ/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 11:52:22.905396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 11:52:22.905732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 11:52:22.907628) ========= ========= Total master_lag: 0.80 =========