builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0007 starttime: 1458203298.27 results: success (0) buildid: 20160317003319 builduid: 82251e95b9264d6c8153fb22df4cf05a revision: 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.267136) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.267640) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.268002) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005158 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.291502) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.291860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.308443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.308749) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005397 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.357807) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.358143) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:18.358531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-17 01:28:18.358870) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-17 01:28:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-03-17 01:28:18 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156377 ========= master_lag: 4.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-17 01:28:22.600716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:22.601066) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.020281 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:22.669305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:22.669661) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 --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 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-17 01:28:22,745 truncating revision to first 12 chars 2016-03-17 01:28:22,745 Setting DEBUG logging. 2016-03-17 01:28:22,745 attempt 1/10 2016-03-17 01:28:22,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8671dfbbff2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 01:28:23,435 unpacking tar archive at: fx-team-8671dfbbff2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.924849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:23.612178) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:23.612535) ========= echo 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 program finished with exit code 0 elapsedTime=0.005125 script_repo_revision: '8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:23.661244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:23.661531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 01:28:23.675250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-17 01:28:23.675527) ========= /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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:28:23 INFO - MultiFileLogger online at 20160317 01:28:23 in /builds/slave/test 01:28:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:28:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:28:23 INFO - {'append_to_log': False, 01:28:23 INFO - 'base_work_dir': '/builds/slave/test', 01:28:23 INFO - 'blob_upload_branch': 'Fx-Team', 01:28:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:28:23 INFO - 'branch': 'Fx-Team', 01:28:23 INFO - 'buildbot_json_path': 'buildprops.json', 01:28:23 INFO - 'config_files': ('talos/mac_config.py',), 01:28:23 INFO - 'default_actions': ('clobber', 01:28:23 INFO - 'read-buildbot-config', 01:28:23 INFO - 'download-and-extract', 01:28:23 INFO - 'populate-webroot', 01:28:23 INFO - 'create-virtualenv', 01:28:23 INFO - 'install', 01:28:23 INFO - 'run-tests'), 01:28:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:28:23 INFO - 'download_minidump_stackwalk': True, 01:28:23 INFO - 'download_symbols': 'ondemand', 01:28:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:28:23 INFO - 'tooltool.py': '/tools/tooltool.py', 01:28:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:28:23 INFO - '/tools/misc-python/virtualenv.py')}, 01:28:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:28:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:28:23 INFO - 'installer_path': 'installer.exe', 01:28:23 INFO - 'log_level': 'info', 01:28:23 INFO - 'log_name': 'talos', 01:28:23 INFO - 'log_to_console': True, 01:28:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:28:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:28:23 INFO - 'opt_config_files': (), 01:28:23 INFO - 'pip_index': False, 01:28:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:28:23 INFO - 'cmd': ('bash', 01:28:23 INFO - '-c', 01:28:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:28:23 INFO - 'enabled': True, 01:28:23 INFO - 'halt_on_failure': False, 01:28:23 INFO - 'name': 'check_screen_resolution'},), 01:28:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:28:23 INFO - 'cmd': ('bash', 01:28:23 INFO - '-c', 01:28:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:28:23 INFO - 'enabled': True, 01:28:23 INFO - 'halt_on_failure': False, 01:28:23 INFO - 'name': 'check_screen_resolution'},), 01:28:23 INFO - 'run_cmd_checks_enabled': True, 01:28:23 INFO - 'sps_profile': False, 01:28:23 INFO - 'sps_profile_interval': 0, 01:28:23 INFO - 'suite': 'dromaeojs', 01:28:23 INFO - 'system_bits': '32', 01:28:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:28:23 INFO - 'title': 't-yosemite-r7-0007', 01:28:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:28:23 INFO - 'use_talos_json': True, 01:28:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:28:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:28:23 INFO - 'work_dir': 'build'} 01:28:23 INFO - ##### 01:28:23 INFO - ##### Running clobber step. 01:28:23 INFO - ##### 01:28:23 INFO - Running pre-action listener: _resource_record_pre_action 01:28:23 INFO - Running main action method: clobber 01:28:23 INFO - rmtree: /builds/slave/test/build 01:28:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:28:24 INFO - Running post-action listener: _resource_record_post_action 01:28:24 INFO - ##### 01:28:24 INFO - ##### Running read-buildbot-config step. 01:28:24 INFO - ##### 01:28:24 INFO - Running pre-action listener: _resource_record_pre_action 01:28:24 INFO - Running main action method: read_buildbot_config 01:28:24 INFO - Using buildbot properties: 01:28:24 INFO - { 01:28:24 INFO - "project": "", 01:28:24 INFO - "product": "firefox", 01:28:24 INFO - "script_repo_revision": "production", 01:28:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:28:24 INFO - "repository": "", 01:28:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:28:24 INFO - "buildid": "20160317003319", 01:28:24 INFO - "pgo_build": "False", 01:28:24 INFO - "basedir": "/builds/slave/test", 01:28:24 INFO - "buildnumber": 513, 01:28:24 INFO - "slavename": "t-yosemite-r7-0007", 01:28:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:28:24 INFO - "platform": "yosemite_r7", 01:28:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:28:24 INFO - "branch": "fx-team", 01:28:24 INFO - "repo_path": "integration/fx-team", 01:28:24 INFO - "revision": "8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484", 01:28:24 INFO - "stage_platform": "macosx64", 01:28:24 INFO - "builduid": "82251e95b9264d6c8153fb22df4cf05a", 01:28:24 INFO - "slavebuilddir": "test" 01:28:24 INFO - } 01:28:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:28:24 INFO - Running post-action listener: _resource_record_post_action 01:28:24 INFO - ##### 01:28:24 INFO - ##### Running download-and-extract step. 01:28:24 INFO - ##### 01:28:24 INFO - Running pre-action listener: _resource_record_pre_action 01:28:24 INFO - Running main action method: download_and_extract 01:28:24 INFO - mkdir: /builds/slave/test/build/tests 01:28: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')]} 01:28:24 INFO - https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:28:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:28:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:28:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:25 INFO - Downloaded 1199 bytes. 01:28:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:28:25 INFO - Using the following test package requirements: 01:28:25 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:28:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:28:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:28:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'jsshell-mac.zip'], 01:28:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:28:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:28:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:28:25 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:28:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:28:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:28:25 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:28:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:25 INFO - https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:28:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:28:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:28:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:26 INFO - Downloaded 17855267 bytes. 01:28: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'] 01:28: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 01:28:30 INFO - Return code: 0 01:28:30 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 01:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:30 INFO - https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:28:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:28:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:28:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:31 INFO - Downloaded 17855267 bytes. 01:28:31 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'] 01:28:31 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 01:28:34 INFO - Return code: 0 01:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:34 INFO - https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:36 INFO - Downloaded 10846462 bytes. 01:28:36 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'] 01:28:36 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 01:28:36 INFO - Return code: 0 01:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:36 INFO - https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:28:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:28:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:28:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:28:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bP_S0WssQYO8O_XJrEF5YA/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 01:28:39 INFO - Downloaded 111154881 bytes. 01:28:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:28:39 INFO - mkdir: /builds/slave/test/properties 01:28:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:28:39 INFO - Writing to file /builds/slave/test/properties/build_url 01:28:39 INFO - Contents: 01:28:39 INFO - build_url:https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:28:41 INFO - Running post-action listener: _resource_record_post_action 01:28:41 INFO - Running post-action listener: set_extra_try_arguments 01:28:41 INFO - ##### 01:28:41 INFO - ##### Running populate-webroot step. 01:28:41 INFO - ##### 01:28:41 INFO - Running pre-action listener: _resource_record_pre_action 01:28:41 INFO - Running main action method: populate_webroot 01:28:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:28:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:28:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:28:41 INFO - '--tppagecycles', 01:28:41 INFO - '7'], 01:28:41 INFO - 'tests': ['tsvgm']}}, 01:28:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:28:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:28:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:28:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:28:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:28:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:28:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'tests': ['damp', 'tps']}, 01:28:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['damp', 'tps']}, 01:28:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:28:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:28:41 INFO - 'other': {'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'other_l64': {'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'other_nol64': {'tests': ['a11yr', 01:28:41 INFO - 'ts_paint', 01:28:41 INFO - 'tpaint', 01:28:41 INFO - 'sessionrestore', 01:28:41 INFO - 'sessionrestore_no_auto_restore', 01:28:41 INFO - 'tabpaint']}, 01:28:41 INFO - 'svgr': {'tests': ['tsvgx', 01:28:41 INFO - 'tsvgr_opacity', 01:28:41 INFO - 'tart', 01:28:41 INFO - 'tscrollx', 01:28:41 INFO - 'cart']}, 01:28:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['tsvgx', 01:28:41 INFO - 'tsvgr_opacity', 01:28:41 INFO - 'tart', 01:28:41 INFO - 'tscrollx', 01:28:41 INFO - 'cart']}, 01:28:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'tests': ['tp5o']}, 01:28:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'talos_options': ['--e10s'], 01:28:41 INFO - 'tests': ['tp5o']}, 01:28:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'talos_options': ['--xperf_path', 01:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:28:41 INFO - 'tests': ['tp5n']}, 01:28:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:28:41 INFO - 'talos_options': ['--e10s', 01:28:41 INFO - '--xperf_path', 01:28:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:28:41 INFO - 'tests': ['tp5n']}}, 01:28:41 INFO - 'talos.zip': {'path': '', 01:28:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:28:41 INFO - Running post-action listener: _resource_record_post_action 01:28:41 INFO - ##### 01:28:41 INFO - ##### Running create-virtualenv step. 01:28:41 INFO - ##### 01:28:41 INFO - Running pre-action listener: _resource_record_pre_action 01:28:41 INFO - Running main action method: create_virtualenv 01:28:41 INFO - Creating virtualenv /builds/slave/test/build/venv 01:28:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:28:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:28:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:28:41 INFO - Using real prefix '/tools/python27' 01:28:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:28:41 INFO - Installing distribute.............................................................................................................................................................................................done. 01:28:44 INFO - Installing pip.................done. 01:28:44 INFO - Return code: 0 01:28:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:28:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:28:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:44 INFO - 'HOME': '/Users/cltbld', 01:28:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:44 INFO - 'LOGNAME': 'cltbld', 01:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:44 INFO - 'MOZ_NO_REMOTE': '1', 01:28:44 INFO - 'NO_EM_RESTART': '1', 01:28:44 INFO - 'PAGER': '/bin/cat', 01:28:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:44 INFO - 'PWD': '/builds/slave/test', 01:28:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:44 INFO - 'SHELL': '/bin/bash', 01:28:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:28:44 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:28:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:44 INFO - 'USER': 'cltbld', 01:28:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:44 INFO - 'XPC_FLAGS': '0x0', 01:28:44 INFO - 'XPC_SERVICE_NAME': '0', 01:28:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:28:45 INFO - Cleaning up... 01:28:45 INFO - Return code: 0 01:28:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:45 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:45 INFO - 'HOME': '/Users/cltbld', 01:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:45 INFO - 'LOGNAME': 'cltbld', 01:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:45 INFO - 'MOZ_NO_REMOTE': '1', 01:28:45 INFO - 'NO_EM_RESTART': '1', 01:28:45 INFO - 'PAGER': '/bin/cat', 01:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:45 INFO - 'PWD': '/builds/slave/test', 01:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:45 INFO - 'SHELL': '/bin/bash', 01:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:28:45 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:45 INFO - 'USER': 'cltbld', 01:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:45 INFO - 'XPC_FLAGS': '0x0', 01:28:45 INFO - 'XPC_SERVICE_NAME': '0', 01:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:45 INFO - Downloading/unpacking psutil>=0.7.1 01:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:28:47 INFO - Installing collected packages: psutil 01:28:47 INFO - Running setup.py install for psutil 01:28:47 INFO - building 'psutil._psutil_osx' extension 01:28:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:28:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:28:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:28:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:28:48 INFO - building 'psutil._psutil_posix' extension 01:28:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:28:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:28:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:28:48 INFO - ^ 01:28:48 INFO - 1 warning generated. 01:28:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:28:48 INFO - Successfully installed psutil 01:28:48 INFO - Cleaning up... 01:28:48 INFO - Return code: 0 01:28:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:48 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:48 INFO - 'HOME': '/Users/cltbld', 01:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:48 INFO - 'LOGNAME': 'cltbld', 01:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:48 INFO - 'MOZ_NO_REMOTE': '1', 01:28:48 INFO - 'NO_EM_RESTART': '1', 01:28:48 INFO - 'PAGER': '/bin/cat', 01:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:48 INFO - 'PWD': '/builds/slave/test', 01:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:48 INFO - 'SHELL': '/bin/bash', 01:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:28:48 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:48 INFO - 'USER': 'cltbld', 01:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:48 INFO - 'XPC_FLAGS': '0x0', 01:28:48 INFO - 'XPC_SERVICE_NAME': '0', 01:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:28:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:28:51 INFO - Installing collected packages: mozsystemmonitor 01:28:51 INFO - Running setup.py install for mozsystemmonitor 01:28:51 INFO - Successfully installed mozsystemmonitor 01:28:51 INFO - Cleaning up... 01:28:51 INFO - Return code: 0 01:28:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:51 INFO - 'HOME': '/Users/cltbld', 01:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:51 INFO - 'LOGNAME': 'cltbld', 01:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:51 INFO - 'MOZ_NO_REMOTE': '1', 01:28:51 INFO - 'NO_EM_RESTART': '1', 01:28:51 INFO - 'PAGER': '/bin/cat', 01:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:51 INFO - 'PWD': '/builds/slave/test', 01:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:51 INFO - 'SHELL': '/bin/bash', 01:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:28:51 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:51 INFO - 'USER': 'cltbld', 01:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:51 INFO - 'XPC_FLAGS': '0x0', 01:28:51 INFO - 'XPC_SERVICE_NAME': '0', 01:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:51 INFO - Downloading/unpacking blobuploader==1.2.4 01:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:54 INFO - Downloading blobuploader-1.2.4.tar.gz 01:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:28:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:28:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:55 INFO - Downloading docopt-0.6.1.tar.gz 01:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:28:55 INFO - Installing collected packages: blobuploader, requests, docopt 01:28:55 INFO - Running setup.py install for blobuploader 01:28:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:28:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:28:55 INFO - Running setup.py install for requests 01:28:56 INFO - Running setup.py install for docopt 01:28:56 INFO - Successfully installed blobuploader requests docopt 01:28:56 INFO - Cleaning up... 01:28:56 INFO - Return code: 0 01:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:56 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:28:56 INFO - 'HOME': '/Users/cltbld', 01:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:28:56 INFO - 'LOGNAME': 'cltbld', 01:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:56 INFO - 'MOZ_NO_REMOTE': '1', 01:28:56 INFO - 'NO_EM_RESTART': '1', 01:28:56 INFO - 'PAGER': '/bin/cat', 01:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:56 INFO - 'PWD': '/builds/slave/test', 01:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:28:56 INFO - 'SHELL': '/bin/bash', 01:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:28:56 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:28:56 INFO - 'USER': 'cltbld', 01:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:56 INFO - 'XPC_FLAGS': '0x0', 01:28:56 INFO - 'XPC_SERVICE_NAME': '0', 01:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:56 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-4G_FeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:56 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-RXRQw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:56 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-pbCokW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:56 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-1OKDHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:56 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-P95lPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-9CdHMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-cNax8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hXUnfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-cZF4ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-00WeTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-For1eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0ezsbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-xsRl5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:57 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-MbjYdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:58 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Ut3EYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:58 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-H_B7M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:58 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3rWcDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:28:58 INFO - Running setup.py install for manifestparser 01:28:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:28:58 INFO - Running setup.py install for mozcrash 01:28:58 INFO - Running setup.py install for mozdebug 01:28:58 INFO - Running setup.py install for mozdevice 01:28:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:28:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:28:58 INFO - Running setup.py install for mozfile 01:28:59 INFO - Running setup.py install for mozhttpd 01:28:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Running setup.py install for mozinfo 01:28:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Running setup.py install for mozInstall 01:28:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Running setup.py install for mozleak 01:28:59 INFO - Running setup.py install for mozlog 01:28:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Running setup.py install for moznetwork 01:28:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:28:59 INFO - Running setup.py install for mozprocess 01:29:00 INFO - Running setup.py install for mozprofile 01:29:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:29:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:29:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:29:00 INFO - Running setup.py install for mozrunner 01:29:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:29:00 INFO - Running setup.py install for mozscreenshot 01:29:00 INFO - Running setup.py install for moztest 01:29:00 INFO - Running setup.py install for mozversion 01:29:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:29:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:29:00 INFO - Cleaning up... 01:29:00 INFO - Return code: 0 01:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:00 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:00 INFO - 'HOME': '/Users/cltbld', 01:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:00 INFO - 'LOGNAME': 'cltbld', 01:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:00 INFO - 'MOZ_NO_REMOTE': '1', 01:29:00 INFO - 'NO_EM_RESTART': '1', 01:29:00 INFO - 'PAGER': '/bin/cat', 01:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:00 INFO - 'PWD': '/builds/slave/test', 01:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:00 INFO - 'SHELL': '/bin/bash', 01:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:29:00 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:00 INFO - 'USER': 'cltbld', 01:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:00 INFO - 'XPC_FLAGS': '0x0', 01:29:00 INFO - 'XPC_SERVICE_NAME': '0', 01:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-xGRgQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-iyQH6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8sxQkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-9Utny7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hHoZ6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-MIZbBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-C9mTfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:29:01 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-buAYof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-fYeo9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-JSojf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-e2mS1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-1MWvm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-BbGqWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-MZFWmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lx5_qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UtJTw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:29:02 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-egy_K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:29:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:05 INFO - Downloading blessings-1.6.tar.gz 01:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:29:05 INFO - Installing collected packages: blessings 01:29:05 INFO - Running setup.py install for blessings 01:29:05 INFO - Successfully installed blessings 01:29:05 INFO - Cleaning up... 01:29:05 INFO - Return code: 0 01:29:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:29:05 INFO - Reading from file tmpfile_stdout 01:29:05 INFO - Current package versions: 01:29:05 INFO - blessings == 1.6 01:29:05 INFO - blobuploader == 1.2.4 01:29:05 INFO - docopt == 0.6.1 01:29:05 INFO - manifestparser == 1.1 01:29:05 INFO - mozInstall == 1.12 01:29:05 INFO - mozcrash == 0.17 01:29:05 INFO - mozdebug == 0.1 01:29:05 INFO - mozdevice == 0.48 01:29:05 INFO - mozfile == 1.2 01:29:05 INFO - mozhttpd == 0.7 01:29:05 INFO - mozinfo == 0.9 01:29:05 INFO - mozleak == 0.1 01:29:05 INFO - mozlog == 3.1 01:29:05 INFO - moznetwork == 0.27 01:29:05 INFO - mozprocess == 0.22 01:29:05 INFO - mozprofile == 0.28 01:29:05 INFO - mozrunner == 6.11 01:29:05 INFO - mozscreenshot == 0.1 01:29:05 INFO - mozsystemmonitor == 0.0 01:29:05 INFO - moztest == 0.7 01:29:05 INFO - mozversion == 1.4 01:29:05 INFO - psutil == 3.1.1 01:29:05 INFO - requests == 1.2.3 01:29:05 INFO - wsgiref == 0.1.2 01:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:29: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')]} 01:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29: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')]} 01:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:05 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:05 INFO - 'HOME': '/Users/cltbld', 01:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:05 INFO - 'LOGNAME': 'cltbld', 01:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:05 INFO - 'MOZ_NO_REMOTE': '1', 01:29:05 INFO - 'NO_EM_RESTART': '1', 01:29:05 INFO - 'PAGER': '/bin/cat', 01:29:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:05 INFO - 'PWD': '/builds/slave/test', 01:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:05 INFO - 'SHELL': '/bin/bash', 01:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:29:05 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:05 INFO - 'USER': 'cltbld', 01:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:05 INFO - 'XPC_FLAGS': '0x0', 01:29:05 INFO - 'XPC_SERVICE_NAME': '0', 01:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:29:06 INFO - Cleaning up... 01:29:06 INFO - Return code: 0 01:29:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:06 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:29:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:29:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:06 INFO - 'HOME': '/Users/cltbld', 01:29:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:06 INFO - 'LOGNAME': 'cltbld', 01:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:06 INFO - 'MOZ_NO_REMOTE': '1', 01:29:06 INFO - 'NO_EM_RESTART': '1', 01:29:06 INFO - 'PAGER': '/bin/cat', 01:29:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:06 INFO - 'PWD': '/builds/slave/test', 01:29:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:06 INFO - 'SHELL': '/bin/bash', 01:29:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:29:06 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:29:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:06 INFO - 'USER': 'cltbld', 01:29:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:06 INFO - 'XPC_FLAGS': '0x0', 01:29:06 INFO - 'XPC_SERVICE_NAME': '0', 01:29:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:06 INFO - Downloading/unpacking jsonschema 01:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:29:08 INFO - Downloading/unpacking functools32 (from jsonschema) 01:29: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 01:29: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 01:29: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 01:29: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 01:29: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 01:29: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 01:29:09 INFO - Downloading functools32-3.2.3-2.tar.gz 01:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:29:09 INFO - warning: no files found matching '*.txt' 01:29:09 INFO - no previously-included directories found matching 'build' 01:29:09 INFO - no previously-included directories found matching 'dist' 01:29:09 INFO - no previously-included directories found matching '.git*' 01:29:09 INFO - Installing collected packages: jsonschema, functools32 01:29:09 INFO - Running setup.py install for functools32 01:29:09 INFO - warning: no files found matching '*.txt' 01:29:09 INFO - no previously-included directories found matching 'build' 01:29:09 INFO - no previously-included directories found matching 'dist' 01:29:09 INFO - no previously-included directories found matching '.git*' 01:29:09 INFO - Successfully installed jsonschema functools32 01:29:09 INFO - Cleaning up... 01:29:09 INFO - Return code: 0 01:29:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:09 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 0x104a6da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb79a4609a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, '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.GKVlwzhZOe/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.41tgwp1yG9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:29:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:29:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:09 INFO - 'HOME': '/Users/cltbld', 01:29:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:09 INFO - 'LOGNAME': 'cltbld', 01:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:09 INFO - 'MOZ_NO_REMOTE': '1', 01:29:09 INFO - 'NO_EM_RESTART': '1', 01:29:09 INFO - 'PAGER': '/bin/cat', 01:29:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:09 INFO - 'PWD': '/builds/slave/test', 01:29:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:09 INFO - 'SHELL': '/bin/bash', 01:29:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:29:09 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:29:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:09 INFO - 'USER': 'cltbld', 01:29:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:09 INFO - 'XPC_FLAGS': '0x0', 01:29:09 INFO - 'XPC_SERVICE_NAME': '0', 01:29:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:09 INFO - Downloading/unpacking flake8 01:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:29:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:29:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:29:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:29:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:29:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:29:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:29:13 INFO - no previously-included directories found matching 'docs/_build' 01:29:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:29:13 INFO - Running setup.py install for pep8 01:29:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:29:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:29:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:29:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:29:13 INFO - no previously-included directories found matching 'docs/_build' 01:29:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:29:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:29:13 INFO - Cleaning up... 01:29:13 INFO - Return code: 0 01:29:13 INFO - Running post-action listener: _resource_record_post_action 01:29:13 INFO - Running post-action listener: _start_resource_monitoring 01:29:13 INFO - Starting resource monitoring. 01:29:13 INFO - ##### 01:29:13 INFO - ##### Running install step. 01:29:13 INFO - ##### 01:29:13 INFO - Running pre-action listener: _resource_record_pre_action 01:29:13 INFO - Running main action method: install 01:29:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:29:14 INFO - Reading from file tmpfile_stdout 01:29:14 INFO - Detecting whether we're running mozinstall >=1.0... 01:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:29:14 INFO - Reading from file tmpfile_stdout 01:29:14 INFO - Output received: 01:29:14 INFO - Usage: mozinstall [options] installer 01:29:14 INFO - Options: 01:29:14 INFO - -h, --help show this help message and exit 01:29:14 INFO - -d DEST, --destination=DEST 01:29:14 INFO - Directory to install application into. [default: 01:29:14 INFO - "/builds/slave/test"] 01:29:14 INFO - --app=APP Application being installed. [default: firefox] 01:29:14 INFO - mkdir: /builds/slave/test/build/application 01:29:14 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'] 01:29:14 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 01:29:48 INFO - Reading from file tmpfile_stdout 01:29:48 INFO - Output received: 01:29:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:29:48 INFO - Running post-action listener: _resource_record_post_action 01:29:48 INFO - ##### 01:29:48 INFO - ##### Running run-tests step. 01:29:48 INFO - ##### 01:29:48 INFO - Running pre-action listener: _resource_record_pre_action 01:29:48 INFO - Running main action method: run_tests 01:29:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:29:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:29:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:29:48 INFO - 2016-03-17 01:29:48.743 screenresolution[2542:19512] starting screenresolution argv=screenresolution get 01:29:48 INFO - 2016-03-17 01:29:48.746 screenresolution[2542:19512] Display 0: 1600x1200x32@60 01:29:48 INFO - 2016-03-17 01:29:48.752 screenresolution[2543:19515] starting screenresolution argv=screenresolution list 01:29:48 INFO - Available Modes on Display 0 01:29:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:29:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:29:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:29:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:29:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:29:48 INFO - Intel Iris: 01:29:48 INFO - Chipset Model: Intel Iris 01:29:48 INFO - Type: GPU 01:29:48 INFO - Bus: Built-In 01:29:48 INFO - VRAM (Dynamic, Max): 1536 MB 01:29:48 INFO - Vendor: Intel (0x8086) 01:29:48 INFO - Device ID: 0x0a2e 01:29:48 INFO - Revision ID: 0x0009 01:29:48 INFO - Displays: 01:29:48 INFO - Display: 01:29:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:29:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:29:48 INFO - Display Serial Number: 1600x1200 60 01:29:48 INFO - Main Display: Yes 01:29:48 INFO - Mirror: Off 01:29:48 INFO - Online: Yes 01:29:48 INFO - Rotation: Supported 01:29:48 INFO - Return code: 0 01:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:29:48 INFO - Python 2.7.3 01:29:48 INFO - Return code: 0 01:29:48 INFO - grabbing minidump binary from tooltool 01:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:48 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 0x104911d30>, '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 0x104735db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104908b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:29:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:29:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:29:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:29:49 INFO - Return code: 0 01:29:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:29:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:29:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:29:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:29:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:29:50 INFO - Return code: 0 01:29:50 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/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:29:50 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/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:29:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKVlwzhZOe/Render', 01:29:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:29:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:29:50 INFO - 'HOME': '/Users/cltbld', 01:29:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:29:50 INFO - 'LOGNAME': 'cltbld', 01:29:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:29:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:50 INFO - 'MOZ_NO_REMOTE': '1', 01:29:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:29:50 INFO - 'NO_EM_RESTART': '1', 01:29:50 INFO - 'PAGER': '/bin/cat', 01:29:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:50 INFO - 'PWD': '/builds/slave/test', 01:29:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:29:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:29:50 INFO - 'SHELL': '/bin/bash', 01:29:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41tgwp1yG9/Listeners', 01:29:50 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 01:29:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:29:50 INFO - 'USER': 'cltbld', 01:29:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:29:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:50 INFO - 'XPC_FLAGS': '0x0', 01:29:50 INFO - 'XPC_SERVICE_NAME': '0', 01:29:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:29:50 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/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:29:50 INFO - mozversion application_buildid: 20160317003319 01:29:50 INFO - mozversion application_changeset: 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 01:29:50 INFO - mozversion application_display_name: Nightly 01:29:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:29:50 INFO - mozversion application_name: Firefox 01:29:50 INFO - mozversion application_remotingname: firefox 01:29:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:29:50 INFO - mozversion application_vendor: Mozilla 01:29:50 INFO - mozversion application_version: 48.0a1 01:29:50 INFO - mozversion platform_buildid: 20160317003319 01:29:50 INFO - mozversion platform_changeset: 8671dfbbff2dfa2fa6c410f4c0799f4b7c2e7484 01:29:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:29:50 INFO - mozversion platform_version: 48.0a1 01:29:50 INFO - using testdate: 1458203390 01:29:50 INFO - actual date: 1458203390 01:29:50 INFO - starting webserver on 'localhost:53595' 01:29:50 INFO - SUITE-START | Running 2 tests 01:29:50 INFO - TEST-START | dromaeo_css 01:29:50 INFO - operating with platform_type : mac_ 01:29:50 INFO - Initialising browser for dromaeo_css test... 01:29:50 INFO - TEST-INFO | started process 2561 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpMiN9JD/profile http://localhost:53595/getInfo.html) 01:29:52 INFO - PROCESS | 2561 | __metrics Screen width/height:1600/1200 01:29:52 INFO - PROCESS | 2561 | colorDepth:24 01:29:52 INFO - PROCESS | 2561 | Browser inner width/height: 1024/689 01:29:52 INFO - PROCESS | 2561 | __metrics 01:29:52 INFO - PROCESS | 2561 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:29:52 ERROR - PROCESS | 2561 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:29:53 INFO - TEST-INFO | 2561: exit 0 01:29:53 INFO - Browser initialized. 01:29:53 INFO - Running cycle 1/1 for dromaeo_css test... 01:29:53 INFO - TEST-INFO | started process 2564 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpMiN9JD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:05 INFO - PROCESS | 2564 | RSS: Main: 243019776 01:30:05 INFO - PROCESS | 2564 | 01:30:56 INFO - PROCESS | 2564 | 1458203456388 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:33:07 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53595/tests/dromaeo/cssquery-ext.html) 01:33:09 INFO - PROCESS | 2564 | RSS: Main: 382472192 01:33:09 INFO - PROCESS | 2564 | 01:36:11 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-ext.html (next: http://localhost:53595/tests/dromaeo/cssquery-jquery.html) 01:36:12 INFO - PROCESS | 2564 | RSS: Main: 379166720 01:36:12 INFO - PROCESS | 2564 | 01:39:14 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53595/tests/dromaeo/cssquery-mootools.html) 01:39:14 INFO - PROCESS | 2564 | RSS: Main: 371814400 01:39:14 INFO - PROCESS | 2564 | 01:42:17 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53595/tests/dromaeo/cssquery-prototype.html) 01:42:17 INFO - PROCESS | 2564 | RSS: Main: 332447744 01:42:17 INFO - PROCESS | 2564 | 01:45:20 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53595/tests/dromaeo/cssquery-yui.html) 01:45:21 INFO - PROCESS | 2564 | RSS: Main: 334045184 01:45:21 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | Cycle 1(1): loaded http://localhost:53595/tests/dromaeo/cssquery-yui.html (next: http://localhost:53595/tests/dromaeo/cssquery-dojo.html) 01:48:24 INFO - PROCESS | 2564 | RSS: Main: 397774848 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | __start_tp_report 01:48:24 INFO - PROCESS | 2564 | _x_x_mozilla_page_load 01:48:24 INFO - PROCESS | 2564 | _x_x_mozilla_page_load_details 01:48:24 INFO - PROCESS | 2564 | |i|pagename|runs| 01:48:24 INFO - PROCESS | 2564 | |0;dojo.html;3384.6276909539947;3432.794032358057;3434.793912365257;3445.483177523371;3501.7023552997994;5474.698891560963;5582.720863956806;5602.047651899176;5630.634008789426;5652.293463317091;4182;5425.02349577076;5629.437056294359;5634;5791.420857914207;5051.9494805051845;5066.771995260204;5085.567726743213;5089.211172268304;5206.323177986876;5172.353455818023;5175.482451754832;5196.220566914955;5213.843584692465;5262.657927234717;5027.622928280357;5028.969061342416;5134.127198376285;5137.486251374851;5141.971605678842;5134.897302053938;5143.254228136937;5154.175331946871;5162.793488260465;5163.122269214243;5084.211947148198;5125.974370128126;5132.589392848563;5138.691678499302;5138.922916156261;5403.108487099624;5492.203630473599;5508.9724551376985;5512.062949298629;5597.74810133545;5150.459201783834;6021.548383871227;6033.42682445167;6119.84700382494;6134.9079763803575;6189.597676151036;6233.407826256498;6240.656763877985;6241.531885108635;6250.499960003189;5535.114381698909;5639.15412688096;5683.9715801420725;5705.971470142665;5769.307683077974;6306;6331.841703957438;6375.649339286291;6375.776847810304;6392.744290228339;5904.76380944766;5966.731497082642;6029.849253768691;6038.939610603926;6069.514438844882;6049;6136.702895113906;6140.201773769381;6176.969115154486;6215.689215539295;6036.034234522455;6134.570580059442;6140.017597184429;6157.7229024694;6170.413810687977;6135.938640613536;6137.202163718777;6154.969225153845;6164.075388691643;6203.875922481525;4724.267738500538;4791.6406269529925;4823.059503396804;4830.975845120752;4832.44426890905;4360.215161270939;4404.691671583022;4409.536998615099;4410.977945110254;4419.823207071746;5496.945030549643;5515.972420137874;5535.363433205233;5544.584156188302;5559.082751346064;6100.672006988121;6104.580421837897;6122.489639783165;6132.814448934737;6208.317085120633;5566.304211973504;5569.944300557024;5575.60970732053;5590.832275031756;5604.579656525777;5279.1817268323475;5295.802715157554;5300.992811365905;5335.253064570963;5361.624686272002;6172.814815555541;6201.441870231701;6215.223097112951;6274.278457977391;6276.309605943251;6203.2245969253845;6233.781817636361;6237.937620623736;6252.187215661935;6264.780732674334;6209.96895015522;6279.434850863444;6281.874362512815;6291.182146320949;6292.528060395397;6011.879762404815;6030.909536357046;6092.360302168208;6098.32918378969;6098.734805259241;6123.050927106306;6159.4456498915315;6160.414760597736;6167.198264225622;6174.969125154345;5043.470435604356;5776.740046697824;5890.882182356415;5973.761049558143;5974.641521508724;5999.430054144849;6015.157877897011;6026.517878569616;6026.638401695912;6078.513718902565;5825.76696932118;5929.377415371324;5934.495567876779;5938.465538101419;5953.10703394477;5861.062230043172;5943.554233432424;5975.760969561343;6031.396860313934;6139.416755408229;4902.975485122552;5771.913421298768;5805;5857.619254748428;5864.970675146597 01:48:24 INFO - PROCESS | 2564 | |1;ext.html;486.35072178641514;562.4347530731617;564.8870225954809;624.7032659486745;627.9340669229731;24699.382515437122;30571.541426878586;37769.99999999996;38440.23119537607;38577.03557411066;39871.601283987155;41491.792541037255;42082.15835683292;42088.36867446991;42142.7892860536;8682.999999999984;9618;9640.469774162419;9644.710658680217;9645.37305075168;9429.387089839172;9610.087041731025;9619.182369498567;9641.517924103768;9655;8423.789405264855;9662.903370966305;9707.563159657833;9745.074217949283;9757.170640495531;9628.277879159055;9715.65995190172;9733.513324333755;9737;9750.902490975106;9531.332806703533;9661.516924153764;9665.71002869908;9671.177949874269;9671.564779584865;40295.19409611791;40743.388849167284;40782.77651670454;40812.38781418281;40893;3143.921401964946;3165.572647692555;3176.857041433141;3625.274945011008;3639.3267245559655;27189.728102718916;29283.414331713248;29359.2660183495;29367.2658183545;29406;2746.231055304518;2748.8900443982216;2786.6098746175553;2863.599096126544;2874.4682233786607;500039;505143;505183;505605;505951.99999999633;44998;64844.67577662082;66812;66965;67014;38501.6149838498;46955.765221174355;47030.589082327584;47045.5295447048;47255.05489890183;12385.876141238472;12577.559785407468;15160.620984475476;15167.469138580318;15172.165530895685;12445.688857778447;12474.625761227178;12492.437840297209;12541.686457838627;12549.811752823714;14604.707905841824;14650.926745366205;14761.55715328542;14767.187804670846;14863.702725945637;6162.876742465215;6201.627902325875;6297.716602752887;6311.968440157862;6314.62112273265;923.6397804856111;964.8311545479513;966.6660009187276;994.9950250248847;1001.9198464122853;27524.03665871685;28429.85785071103;28731.56902646462;29422.852885735436;29618.703812962027;1106.8948449897248;1133.3709791066037;1134.9092072634169;1144.6394385768456;1146.7649131927935;14621.561353159423;14690.559283221306;14705.55883323502;15061.924690376478;15159.469418570297;522519;522672;527447;529289;530099;58314;58866.41133588695;58956.41043589595;58957;59049.40950590525;1326.2175316563273;1442.8917831162705;1456.6576854439197;1470.7499725046982;1485.2499487758828;28158.2960425991;28418.857905710338;28844.711552884204;28910;28972.13083607495;44963;45454.77272613616;45775.77112114551;45853.85365365759;45916.311255331864;318802;320064;320475.3976230104;320479;320847;28157.296067598472;28604.57093143646;32145.35709285848;33213.667863321054;33264.83367583244;38464;40394.79802600968;41324;42131.789341054326;42197.15605687931;27843.44313113767;31989.04032879017;34551.30897381988;34930.65069349274;35446.113847154025;33966;34297.314053718284;34486.48270275898;35309;35404.46893296654;36200.637993619726;36612;36710.63289367072;37319.44020839744;38464.6153538461;30594.694053059186;31521.52717709282;31589.842050790518;31628.841855791496;31697.366052678357;19849.900750496156;24011.879940600185;24451.586139336127;24571.38571535726;24947.625785613593 01:48:24 INFO - PROCESS | 2564 | |2;jquery.html;355.6141586378779;356.44572689467884;359.29578027066964;367.8289595338167;369.9778013319199;19600.215991360346;19757.802421975775;20576.89711551444;20619.690704639423;20636.1745530179;19521.12154953027;20054.065127992435;20562.89718551405;20596.588068238627;20881.373558793224;5837.09525023622;6046.062860256645;6064.666443345614;6069.15031895535;6079;4190.308599081163;4491.550844915499;5472.945270547303;5955.076963070731;6568.146141001663;6324.083007963843;6528.869422611545;6566.5075119366;6578;6580.111684922546;6260.843478913018;6422.550421470499;6493.772717954849;6496.155499785022;6506.577072490297;5559.805406810742;5574.526165275956;5574.749136288877;5576.86057848553;5584.553235741131;25205;25439;25700.831800367778;25749.841257143285;25867.482650347076;1786.4908501077261;2040.9183632654676;2080.147139672727;2202.876532968182;2207.70196023538;14075.155490670593;14274.714505709828;14610.70778584433;14894.404223831034;14915.627109322353;1579.5656194546477;1723.758673785671;1758.5867321179512;1819.7634307540068;1829.3597240965555;95725;98197.50901245448;98501.99999999929;99194.50402748013;100889;10241.590336386462;10370;10629.73425664349;10632.681019569425;10745.24783265164;12744;12800;12819.16675416095;12855.678608034874;12867.356632168354;8358.791030224293;8522.403431759842;8535.573221338907;8627.439216451035;8627.568621568897;8721.825563488695;8726.389152759246;8728.519931403835;8817.559122043873;8853.69012084574;5598.664080155204;5901.557383196192;6161.537884658668;6221.844453888599;6245.781397651061;1557.9454719084777;1770.530809335527;1802.152988095593;1802.5493626593352;1807.2319264312614;891.8795962545103;901.9098090190928;946.8911075226437;1007.1036777268237;1057.9259451838452;19840.404787856387;20704.48238794042;20727.8963605181;20830.89584552098;21001.579968400547;952.7570469530225;975.1857199238574;980.9901900981041;997.2719914462338;1023.0843395161438;10855;11289.122761471652;11300.875180559036;11311;11361.431928403546;632427;655253;655722;669228;673708;70995;73377;75931.62034189794;91169;91924;980.8773903262235;1023.1610079734695;1034.6533911139702;1062.5484169228048;1068.423051552153;13688.863111368759;17738.201780920146;17881.46355609334;17958.461246162635;18512.907435462737;39351.80324098476;50259.49740502548;50673;51677;52304.47695523148;71518;71611.64194178996;74384.62807685927;74495;76701.23298767164;6548.8035358939305;7305.525140865827;7553.169151393233;7655.846883062419;7859.764207073797;10700.678979630313;11917.642470725892;11938.940305298418;12044.277343359427;12208.32854193028;10416;10498.947505262426;10681.03870651645;10699.197560183173;10836.458177091272;10210.43842588635;10319.174466042849;10379.636712715019;10573.788524229318;10683.786324273315;7936.738029661749;10778.89221107779;10867;11122.944385278022;11136.610218642309;7373.410127189919;7404.592747398945;7626.771196864103;7720.112187098555;7867.331276841303;9354.532273386167;9854;10570.402277435907;10802.459877005962;10911 01:48:24 INFO - PROCESS | 2564 | |3;mootools.html;1458.934347954342;1612.226131456901;1640.745684418915;1922.6154769046195;2045.4477291131395;7844.019497562805;8561.315094792417;8722.86915696265;8731.170538798811;8754.95622521888;8423.663053477854;8675.219230269275;8680.218780309771;8689.73930782076;8695.17395847395;2153.9784602153936;2436.7806897379232;2459.360566252774;2488.4525404411;2492.4890397468475;2496.962545561818;2505.8621775802417;2507.4608959073794;2510.585753350704;2514.5473814713346;2431.2827715823787;2459.139301244559;2463.987680061597;2477.8389404688637;2481;2435.8538487690794;2458.9016439342404;2466.90132394704;2474.406142525781;2476.0838489758903;2426.1265944260053;2451.301379106964;2477.6035834266613;2478.8512689238523;2492.7507249274927;8399.874001889977;8749.650013999433;8798;8808.207261346446;8841.60212790426;4887.633427492952;5481.808136715196;5543.6119471637;5545.667259964415;5547.667139971614;3597.262561174979;3683.9815800920824;3748.137928276484;3752.962470375316;3763.9623603763885;1055.7044027672264;1069.2408390043079;1076.94615269237;1083.8374243863404;1084.7450849050467;11792.174547781744;11890.88109118915;11933.045356371556;11944.104192185534;11945.283283003047;4817.108834865561;4857.975710121426;4934.827281045146;4950.5544500994365;4970.676906001098;9988.60045598168;9993.40039597612;10018.599256029824;10041.548130334153;10046.29675922693;5441.863953401117;5472.5621950243885;5483.835484935458;5488.670679759227;5491;4375.343698445258;4512.029913568598;4784.234522476457;4913.508649135058;4966.106100901872;3841.6158384161918;3915.882523524299;3921.8627348042683;3944.0928586425284;3962.2867883781196;1309.3256972659087;1317.8682131786745;1322.814805927171;1331.6071758831167;1333.113479536117;1335.5258883096556;1349.2444231230543;1363.3047145955634;1416.2564653556758;1424.9358778854976;8179.427440079137;8193.754187374388;8198.344132469389;8202.876956845652;8231.506109633441;508.8041104174919;523.5183631059434;523.7512181713655;524.1247117314094;529.4255732530248;6195.690215489208;6215.316315205324;6221.097940798559;6226.066090086432;6251.9687401562705;10385.896141038493;10615.681529554126;10703.304285221435;10722.517486713117;10739.14086873064;10333.173346132442;10451.16390688743;10536.736581585521;10558.472076396149;10578.418186999636;8279.420440569102;8336.333093352518;8350.290225330793;8370.246677799027;8378.287845533076;6281.96859015702;7627.733029343946;7861.52830830152;7884.526928384315;7895;7268.345848873627;9406;9535.952320238632;9589.753332066786;9642.180414664552;9661.227101831695;9789.510524473606;9939.552720127756;9945.701628951143;10083.949580252052;6743.561668491532;6940.479464040116;7172.211056783854;7493.775186744407;7558.848823023399;8160.30637395828;8201.671933122609;8223.712170074019;8234.876476852973;8240.917590824254;7236.38490728294;7281.854362912606;7318.048653674989;7431.591262480615;7458.03045604068;7182.712691492282;7239.855202895807;7255.165655949633;7333.413326933939;7350.411967042517;7636.007319048488;7712.190220026816;7717.961410192913;7718.961405192938;7731.304182623591;6912.274211207952;6936.41040511542;7017.473689473208;7022.929770702228;7039.1553013638695;7067.929320706727;7145.606991615303;7157.642117894188;7158.284171583008;7165.283471652793 01:48:24 INFO - PROCESS | 2564 | |4;prototype.html;323.2968293960636;326.3701056960066;331.71141107236707;333.21029160888696;336.83495087407175;6443.903341449876;6491.772787952423;6551.541392102555;6582.308857569946;6590.934090659098;6448.322926092751;6475.255345635242;6488.448481879046;6513.38122878327;6520.902186467207;4624.606908412789;4692.835750748724;4756.1914474539235;4801.375821143247;4869.001854619803;4760.3573517575205;4772.57046865782;4792.760361981905;4805.783739731721;4812.398450193726;4740.170470167707;4760.428748550162;4761.309610106549;4762.238041913294;4769.499202583731;4555.977220113895;4672.182368085605;4775.42694876617;4777.355057067286;4778.259369797687;4111.814968326403;4113.91772164555;4114.7119701620895;4121.670266378683;4122.361034039729;5529.502344788948;6120.540959428061;6146.5390095743;6214.627122372672;6235.251769787655;5587.273654424939;5588.804391846306;5591.916121258185;5597.496225339739;5615.859603509904;6894.620795856226;6898.482613803934;6899.689513971884;6914.135733033371;6923.065386172852;3726.273376691546;4283.121959998193;4489.73061616304;4495.078508905666;4497.572730590588;5894.027485464893;7165.211826699111;7296.343329100353;7305.926940730577;7320.26797320269;4558.111168322212;4561.954380456219;4563.315502674625;4563.520830312769;4563.885902852388;4613.95386046142;4623.42207224097;4637.420322459692;4637.86086417408;4642.489326174118;5462.8361149165585;5467.17992301158;5473.67157970523;5480.80817171405;5481.835544933659;6682.565633233824;6897.586144831326;6903.6548172591165;6961.26906674802;6979.755708550177;1578.2976575424057;1591.0135715856243;1600.6158521954646;1601.3114360824957;1605;958.7698952251549;987.1263931420744;1007.8740157480315;1012.0739523336065;1041.3075304922143;5358;6373.52198585108;6431.5819471734185;6451.806445806634;6506.902396464056;7162.7493037743425;7242.275772422716;7244.963775181091;7258.528195667371;7263.128424589083;6422.710978006001;6431.839204019937;6436.034594810816;6441.5490915635455;6464.644444555594;3084.306031142975;3654.6162652921594;3787.905302367463;3830.4254361845387;3832.2527107213828;6584.967075164594;7124.536905101256;7258.709651613982;7558.168601453835;7569.470137090461;7419.554826710415;7457.291557302047;7468.506298740273;7474.103107627119;7475.8504829903095;7519.73680921187;7532.246775322534;7534.284242996797;7542.358899493604;7572.39420846331;6888.173419189528;7181.784546463406;7185.425165986813;7191.568505889663;7202.207757146814;6764.797056088325;7014.0531028310525;7115.039469671735;7125.608091555015;7148.4281257500315;6229.190205273286;7557.659905304165;7561.3194812467145;7566.432517561095;7578.74114130929;4713.858584242478;4757.952420475751;4764.4282686077895;4765.571098601143;4767.73777442244;5742;7111.6799744010605;7112.35988761014;7112.893306600508;7115.430765538641;5298.788048478018;6893.7931862044215;6895.862082758216;6916.446684265146;6932.2721114284295;6862;6874.65626718652;6893.069435626327;6896.655167241718;6902.723891044302;5438.945610543844;6715.664216789239;6715.731370745116;6726.192856857208;6733.6296503692765;6654.101696270942;6865.176178858569;6880.174379074543;6899.379055884994;6919.37725604698;6624.105745724266;6643.269240383651;6725.092112564741;6731;6800.693968771516 01:48:24 INFO - PROCESS | 2564 | |5;yui.html;679.9116114905062;698.6925752668825;714.7998560403089;767.7543186180421;809.4414853750914;15094.77357839632;15295.541133765977;15307.005044672089;15314.92342538287;15380.846191538081;14094.154350738963;14119.364628591713;14203.218822964758;14358.923080768958;14398.640033999156;905.4069584422214;915.9221466175383;930.2836815651943;930.6603089872182;930.9906900931005;744.7636922708306;758.7913323835961;915.199200699388;926.3978414030867;938.0010289042183;983.0366241083742;983.5770618633984;986.0533887468004;988.9456079915602;990.4305024610842;981.470006196653;983.945882976436;984.5963155106443;984.8227319082562;984.8621193032981;575.9078547432391;715.8103102677794;721.6896734404204;723.1864152828068;724.9673764680549;14285.357183923878;14432.20622865742;15232.086074835435;15330.386784528606;15417.460388886335;12769.361531923367;12791.232526048467;13002.934985325108;13027.478900843955;13142.802857957138;10081.949590252076;10145.695629131063;10241.795164096751;10315.742106447324;10553.630622928238;3481.234128491728;3575.5173051637958;3632.945505817415;3650.379435495972;3662.5421822272215;82447.7632835508;82718.17281827165;83130.58434707849;85308;85729;8951.478248697736;8966.641334346683;9064.954675226581;9524.330343826525;9595.568199431042;22496.32511024672;22613.88693056557;22616.773832261795;22634.320970370914;22639.981200845672;7390;7489.588072655947;7524.887126693104;7574.431917606092;7733.806654833562;3971.205758848242;4018.718689691752;4020.3165461871554;4027.91944161121;4038.1519880825354;3646.3801153803915;3654.780713157166;3696.815159242027;3698.5561732591723;3709.629037096323;669.0332469581408;693.2547511425238;708.1360739897317;713.13710410404;728.7667946257253;411.33774622857175;511.33015749368445;543.7987944460575;567.9318481782212;590.893639144958;7915.722949696733;7994.5602991836;8059.43583949118;8148.959255203686;8192.426530142951;525.8606469285643;534.8662834291428;599.9070144127667;607.4381197392395;609.8841220168242;3575.800882457322;3626.709863210937;3808.21931504041;3883.1845312484693;3973.5033120859894;97017;97838;99367.50316248517;100294;101210.49394753126;63309;83490.5825470881;83537;84619.15380846236;84981.57509212414;68449.65775171191;69052.65473672599;69528.65235673789;69759.99999999898;70751.64624176847;6348.143000694847;6388.137601423934;7414.777556673308;7540.132884718328;7845.529268243924;50345.74827125841;50997;51149.48850511596;51321;51500;70972;71441.92837107343;71462.57074858577;71513.6424317875;71943.56112877608;10007.299489035697;10048.799024019625;10199.337043092175;10317.17462602975;10522;11025.228234023542;11160.386178760245;11306.434678265889;11345.376004319842;11732.648020559396;9920.900790991998;9945.602175912882;9960.053794889474;10020.69937901864;10295.17638588896;8673.913260867563;10029.849552256575;10599.258051936291;10599.947000264949;10678.62624808128;8391.58042097905;9889.950550247491;9903.158231550111;10274.434906080238;10277.9486102569;8698.43460175112;8735.78160545966;8776.824463510822;8813;8993.055729148346;8092.635831387484;8353.665853365797;8359.247667709935;8489.74530764078;8604.526751028754 01:48:24 INFO - PROCESS | 2564 | __end_tp_report 01:48:24 INFO - PROCESS | 2564 | __start_cc_report 01:48:24 INFO - PROCESS | 2564 | _x_x_mozilla_cycle_collect,1227 01:48:24 INFO - PROCESS | 2564 | __end_cc_report 01:48:24 INFO - PROCESS | 2564 | __startTimestamp1458204504461__endTimestamp 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | ------- Summary: start ------- 01:48:24 INFO - PROCESS | 2564 | Number of tests: 6 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#0] dojo.html Cycles:165 Average:5640.82 Median:5857.62 stddev:638.57 (10.9%) stddev-sans-first:615.51 01:48:24 INFO - PROCESS | 2564 | Values: 3384.6 3432.8 3434.8 3445.5 3501.7 5474.7 5582.7 5602.0 5630.6 5652.3 4182.0 5425.0 5629.4 5634.0 5791.4 5051.9 5066.8 5085.6 5089.2 5206.3 5172.4 5175.5 5196.2 5213.8 5262.7 5027.6 5029.0 5134.1 5137.5 5142.0 5134.9 5143.3 5154.2 5162.8 5163.1 5084.2 5126.0 5132.6 5138.7 5138.9 5403.1 5492.2 5509.0 5512.1 5597.7 5150.5 6021.5 6033.4 6119.8 6134.9 6189.6 6233.4 6240.7 6241.5 6250.5 5535.1 5639.2 5684.0 5706.0 5769.3 6306.0 6331.8 6375.6 6375.8 6392.7 5904.8 5966.7 6029.8 6038.9 6069.5 6049.0 6136.7 6140.2 6177.0 6215.7 6036.0 6134.6 6140.0 6157.7 6170.4 6135.9 6137.2 6155.0 6164.1 6203.9 4724.3 4791.6 4823.1 4831.0 4832.4 4360.2 4404.7 4409.5 4411.0 4419.8 5496.9 5516.0 5535.4 5544.6 5559.1 6100.7 6104.6 6122.5 6132.8 6208.3 5566.3 5569.9 5575.6 5590.8 5604.6 5279.2 5295.8 5301.0 5335.3 5361.6 6172.8 6201.4 6215.2 6274.3 6276.3 6203.2 6233.8 6237.9 6252.2 6264.8 6210.0 6279.4 6281.9 6291.2 6292.5 6011.9 6030.9 6092.4 6098.3 6098.7 6123.1 6159.4 6160.4 6167.2 6175.0 5043.5 5776.7 5890.9 5973.8 5974.6 5999.4 6015.2 6026.5 6026.6 6078.5 5825.8 5929.4 5934.5 5938.5 5953.1 5861.1 5943.6 5975.8 6031.4 6139.4 4903.0 5771.9 5805.0 5857.6 5865.0 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#1] ext.html Cycles:180 Average:58822.60 Median:37015.04 stddev:122499.64 (330.9%) stddev-sans-first:122764.98 01:48:24 INFO - PROCESS | 2564 | Values: 486.4 562.4 564.9 624.7 627.9 24699.4 30571.5 37770.0 38440.2 38577.0 39871.6 41491.8 42082.2 42088.4 42142.8 8683.0 9618.0 9640.5 9644.7 9645.4 9429.4 9610.1 9619.2 9641.5 9655.0 8423.8 9662.9 9707.6 9745.1 9757.2 9628.3 9715.7 9733.5 9737.0 9750.9 9531.3 9661.5 9665.7 9671.2 9671.6 40295.2 40743.4 40782.8 40812.4 40893.0 3143.9 3165.6 3176.9 3625.3 3639.3 27189.7 29283.4 29359.3 29367.3 29406.0 2746.2 2748.9 2786.6 2863.6 2874.5 500039.0 505143.0 505183.0 505605.0 505952.0 44998.0 64844.7 66812.0 66965.0 67014.0 38501.6 46955.8 47030.6 47045.5 47255.1 12385.9 12577.6 15160.6 15167.5 15172.2 12445.7 12474.6 12492.4 12541.7 12549.8 14604.7 14650.9 14761.6 14767.2 14863.7 6162.9 6201.6 6297.7 6312.0 6314.6 923.6 964.8 966.7 995.0 1001.9 27524.0 28429.9 28731.6 29422.9 29618.7 1106.9 1133.4 1134.9 1144.6 1146.8 14621.6 14690.6 14705.6 15061.9 15159.5 522519.0 522672.0 527447.0 529289.0 530099.0 58314.0 58866.4 58956.4 58957.0 59049.4 1326.2 1442.9 1456.7 1470.7 1485.2 28158.3 28418.9 28844.7 28910.0 28972.1 44963.0 45454.8 45775.8 45853.9 45916.3 318802.0 320064.0 320475.4 320479.0 320847.0 28157.3 28604.6 32145.4 33213.7 33264.8 38464.0 40394.8 41324.0 42131.8 42197.2 27843.4 31989.0 34551.3 34930.7 35446.1 33966.0 34297.3 34486.5 35309.0 35404.5 36200.6 36612.0 36710.6 37319.4 38464.6 30594.7 31521.5 31589.8 31628.8 31697.4 19849.9 24011.9 24451.6 24571.4 24947.6 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#2] jquery.html Cycles:180 Average:34518.66 Median:356.03 stddev:107970.39 (30326.2%) stddev-sans-first:108242.80 01:48:24 INFO - PROCESS | 2564 | Values: 355.6 356.4 359.3 367.8 370.0 19600.2 19757.8 20576.9 20619.7 20636.2 19521.1 20054.1 20562.9 20596.6 20881.4 5837.1 6046.1 6064.7 6069.2 6079.0 4190.3 4491.6 5472.9 5955.1 6568.1 6324.1 6528.9 6566.5 6578.0 6580.1 6260.8 6422.6 6493.8 6496.2 6506.6 5559.8 5574.5 5574.7 5576.9 5584.6 25205.0 25439.0 25700.8 25749.8 25867.5 1786.5 2040.9 2080.1 2202.9 2207.7 14075.2 14274.7 14610.7 14894.4 14915.6 1579.6 1723.8 1758.6 1819.8 1829.4 95725.0 98197.5 98502.0 99194.5 100889.0 10241.6 10370.0 10629.7 10632.7 10745.2 12744.0 12800.0 12819.2 12855.7 12867.4 8358.8 8522.4 8535.6 8627.4 8627.6 8721.8 8726.4 8728.5 8817.6 8853.7 5598.7 5901.6 6161.5 6221.8 6245.8 1557.9 1770.5 1802.2 1802.5 1807.2 891.9 901.9 946.9 1007.1 1057.9 19840.4 20704.5 20727.9 20830.9 21001.6 952.8 975.2 981.0 997.3 1023.1 10855.0 11289.1 11300.9 11311.0 11361.4 632427.0 655253.0 655722.0 669228.0 673708.0 70995.0 73377.0 75931.6 91169.0 91924.0 980.9 1023.2 1034.7 1062.5 1068.4 13688.9 17738.2 17881.5 17958.5 18512.9 39351.8 50259.5 50673.0 51677.0 52304.5 71518.0 71611.6 74384.6 74495.0 76701.2 6548.8 7305.5 7553.2 7655.8 7859.8 10700.7 11917.6 11938.9 12044.3 12208.3 10416.0 10498.9 10681.0 10699.2 10836.5 10210.4 10319.2 10379.6 10573.8 10683.8 7936.7 10778.9 10867.0 11122.9 11136.6 7373.4 7404.6 7626.8 7720.1 7867.3 9354.5 9854.0 10570.4 10802.5 10911.0 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#3] mootools.html Cycles:180 Average:6012.87 Median:5457.21 stddev:3165.02 (58.0%) stddev-sans-first:3155.38 01:48:24 INFO - PROCESS | 2564 | Values: 1458.9 1612.2 1640.7 1922.6 2045.4 7844.0 8561.3 8722.9 8731.2 8755.0 8423.7 8675.2 8680.2 8689.7 8695.2 2154.0 2436.8 2459.4 2488.5 2492.5 2497.0 2505.9 2507.5 2510.6 2514.5 2431.3 2459.1 2464.0 2477.8 2481.0 2435.9 2458.9 2466.9 2474.4 2476.1 2426.1 2451.3 2477.6 2478.9 2492.8 8399.9 8749.7 8798.0 8808.2 8841.6 4887.6 5481.8 5543.6 5545.7 5547.7 3597.3 3684.0 3748.1 3753.0 3764.0 1055.7 1069.2 1076.9 1083.8 1084.7 11792.2 11890.9 11933.0 11944.1 11945.3 4817.1 4858.0 4934.8 4950.6 4970.7 9988.6 9993.4 10018.6 10041.5 10046.3 5441.9 5472.6 5483.8 5488.7 5491.0 4375.3 4512.0 4784.2 4913.5 4966.1 3841.6 3915.9 3921.9 3944.1 3962.3 1309.3 1317.9 1322.8 1331.6 1333.1 1335.5 1349.2 1363.3 1416.3 1424.9 8179.4 8193.8 8198.3 8202.9 8231.5 508.8 523.5 523.8 524.1 529.4 6195.7 6215.3 6221.1 6226.1 6252.0 10385.9 10615.7 10703.3 10722.5 10739.1 10333.2 10451.2 10536.7 10558.5 10578.4 8279.4 8336.3 8350.3 8370.2 8378.3 6282.0 7627.7 7861.5 7884.5 7895.0 7268.3 9406.0 9536.0 9589.8 9642.2 9661.2 9789.5 9939.6 9945.7 10083.9 6743.6 6940.5 7172.2 7493.8 7558.8 8160.3 8201.7 8223.7 8234.9 8240.9 7236.4 7281.9 7318.0 7431.6 7458.0 7182.7 7239.9 7255.2 7333.4 7350.4 7636.0 7712.2 7718.0 7719.0 7731.3 6912.3 6936.4 7017.5 7022.9 7039.2 7067.9 7145.6 7157.6 7158.3 7165.3 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#4] prototype.html Cycles:180 Average:5632.45 Median:6446.11 stddev:1801.91 (28.0%) stddev-sans-first:1762.36 01:48:24 INFO - PROCESS | 2564 | Values: 323.3 326.4 331.7 333.2 336.8 6443.9 6491.8 6551.5 6582.3 6590.9 6448.3 6475.3 6488.4 6513.4 6520.9 4624.6 4692.8 4756.2 4801.4 4869.0 4760.4 4772.6 4792.8 4805.8 4812.4 4740.2 4760.4 4761.3 4762.2 4769.5 4556.0 4672.2 4775.4 4777.4 4778.3 4111.8 4113.9 4114.7 4121.7 4122.4 5529.5 6120.5 6146.5 6214.6 6235.3 5587.3 5588.8 5591.9 5597.5 5615.9 6894.6 6898.5 6899.7 6914.1 6923.1 3726.3 4283.1 4489.7 4495.1 4497.6 5894.0 7165.2 7296.3 7305.9 7320.3 4558.1 4562.0 4563.3 4563.5 4563.9 4614.0 4623.4 4637.4 4637.9 4642.5 5462.8 5467.2 5473.7 5480.8 5481.8 6682.6 6897.6 6903.7 6961.3 6979.8 1578.3 1591.0 1600.6 1601.3 1605.0 958.8 987.1 1007.9 1012.1 1041.3 5358.0 6373.5 6431.6 6451.8 6506.9 7162.7 7242.3 7245.0 7258.5 7263.1 6422.7 6431.8 6436.0 6441.5 6464.6 3084.3 3654.6 3787.9 3830.4 3832.3 6585.0 7124.5 7258.7 7558.2 7569.5 7419.6 7457.3 7468.5 7474.1 7475.9 7519.7 7532.2 7534.3 7542.4 7572.4 6888.2 7181.8 7185.4 7191.6 7202.2 6764.8 7014.1 7115.0 7125.6 7148.4 6229.2 7557.7 7561.3 7566.4 7578.7 4713.9 4758.0 4764.4 4765.6 4767.7 5742.0 7111.7 7112.4 7112.9 7115.4 5298.8 6893.8 6895.9 6916.4 6932.3 6862.0 6874.7 6893.1 6896.7 6902.7 5438.9 6715.7 6715.7 6726.2 6733.6 6654.1 6865.2 6880.2 6899.4 6919.4 6624.1 6643.3 6725.1 6731.0 6800.7 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - PROCESS | 2564 | [#5] yui.html Cycles:180 Average:18552.67 Median:34564.78 stddev:26915.26 (77.9%) stddev-sans-first:26957.30 01:48:24 INFO - PROCESS | 2564 | Values: 679.9 698.7 714.8 767.8 809.4 15094.8 15295.5 15307.0 15314.9 15380.8 14094.2 14119.4 14203.2 14358.9 14398.6 905.4 915.9 930.3 930.7 931.0 744.8 758.8 915.2 926.4 938.0 983.0 983.6 986.1 988.9 990.4 981.5 983.9 984.6 984.8 984.9 575.9 715.8 721.7 723.2 725.0 14285.4 14432.2 15232.1 15330.4 15417.5 12769.4 12791.2 13002.9 13027.5 13142.8 10081.9 10145.7 10241.8 10315.7 10553.6 3481.2 3575.5 3632.9 3650.4 3662.5 82447.8 82718.2 83130.6 85308.0 85729.0 8951.5 8966.6 9065.0 9524.3 9595.6 22496.3 22613.9 22616.8 22634.3 22640.0 7390.0 7489.6 7524.9 7574.4 7733.8 3971.2 4018.7 4020.3 4027.9 4038.2 3646.4 3654.8 3696.8 3698.6 3709.6 669.0 693.3 708.1 713.1 728.8 411.3 511.3 543.8 567.9 590.9 7915.7 7994.6 8059.4 8149.0 8192.4 525.9 534.9 599.9 607.4 609.9 3575.8 3626.7 3808.2 3883.2 3973.5 97017.0 97838.0 99367.5 100294.0 101210.5 63309.0 83490.6 83537.0 84619.2 84981.6 68449.7 69052.7 69528.7 69760.0 70751.6 6348.1 6388.1 7414.8 7540.1 7845.5 50345.7 50997.0 51149.5 51321.0 51500.0 70972.0 71441.9 71462.6 71513.6 71943.6 10007.3 10048.8 10199.3 10317.2 10522.0 11025.2 11160.4 11306.4 11345.4 11732.6 9920.9 9945.6 9960.1 10020.7 10295.2 8673.9 10029.8 10599.3 10599.9 10678.6 8391.6 9890.0 9903.2 10274.4 10277.9 8698.4 8735.8 8776.8 8813.0 8993.1 8092.6 8353.7 8359.2 8489.7 8604.5 01:48:24 INFO - PROCESS | 2564 | -------- Summary: end -------- 01:48:24 INFO - PROCESS | 2564 | 01:48:24 INFO - TEST-INFO | 2564: exit 0 01:48:25 INFO - TEST-OK | dromaeo_css | took 1114513ms 01:48:25 INFO - TEST-START | kraken 01:48:25 INFO - operating with platform_type : mac_ 01:48:25 INFO - Initialising browser for kraken test... 01:48:25 INFO - TEST-INFO | started process 2569 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmp5Y7X5j/profile http://localhost:53595/getInfo.html) 01:48:27 INFO - PROCESS | 2569 | __metrics Screen width/height:1600/1200 01:48:27 INFO - PROCESS | 2569 | colorDepth:24 01:48:27 INFO - PROCESS | 2569 | Browser inner width/height: 1024/689 01:48:27 INFO - PROCESS | 2569 | __metrics 01:48:27 INFO - PROCESS | 2569 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:48:27 ERROR - PROCESS | 2569 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:48:27 INFO - TEST-INFO | 2569: exit 0 01:48:27 INFO - Browser initialized. 01:48:27 INFO - Running cycle 1/1 for kraken test... 01:48:27 INFO - TEST-INFO | started process 2571 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmp5Y7X5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:39 INFO - PROCESS | 2571 | RSS: Main: 243068928 01:48:39 INFO - PROCESS | 2571 | 01:48:42 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53595/tests/kraken/driver.html?testName=audio-beat-detection) 01:48:43 INFO - PROCESS | 2571 | RSS: Main: 291225600 01:48:43 INFO - PROCESS | 2571 | 01:48:45 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53595/tests/kraken/driver.html?testName=audio-dft) 01:48:46 INFO - PROCESS | 2571 | RSS: Main: 300396544 01:48:46 INFO - PROCESS | 2571 | 01:48:49 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53595/tests/kraken/driver.html?testName=audio-fft) 01:48:50 INFO - PROCESS | 2571 | RSS: Main: 286523392 01:48:50 INFO - PROCESS | 2571 | 01:48:52 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53595/tests/kraken/driver.html?testName=audio-oscillator) 01:48:53 INFO - PROCESS | 2571 | RSS: Main: 289255424 01:48:53 INFO - PROCESS | 2571 | 01:48:55 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:48:55 INFO - PROCESS | 2571 | RSS: Main: 289423360 01:48:55 INFO - PROCESS | 2571 | 01:48:58 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53595/tests/kraken/driver.html?testName=imaging-darkroom) 01:48:59 INFO - PROCESS | 2571 | RSS: Main: 292118528 01:48:59 INFO - PROCESS | 2571 | 01:49:02 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53595/tests/kraken/driver.html?testName=imaging-desaturate) 01:49:02 INFO - PROCESS | 2571 | RSS: Main: 290648064 01:49:02 INFO - PROCESS | 2571 | 01:49:05 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53595/tests/kraken/driver.html?testName=json-parse-financial) 01:49:06 INFO - PROCESS | 2571 | RSS: Main: 292339712 01:49:06 INFO - PROCESS | 2571 | 01:49:07 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:49:08 INFO - PROCESS | 2571 | RSS: Main: 325861376 01:49:08 INFO - PROCESS | 2571 | 01:49:10 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:49:11 INFO - PROCESS | 2571 | RSS: Main: 324894720 01:49:11 INFO - PROCESS | 2571 | 01:49:13 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:49:13 INFO - PROCESS | 2571 | RSS: Main: 332664832 01:49:13 INFO - PROCESS | 2571 | 01:49:16 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:49:16 INFO - PROCESS | 2571 | RSS: Main: 332800000 01:49:16 INFO - PROCESS | 2571 | 01:49:19 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:49:20 INFO - PROCESS | 2571 | RSS: Main: 334405632 01:49:20 INFO - PROCESS | 2571 | 01:49:21 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:53595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53595/tests/kraken/driver.html?testName=ai-astar) 01:49:22 INFO - PROCESS | 2571 | RSS: Main: 394596352 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | __start_tp_report 01:49:22 INFO - PROCESS | 2571 | _x_x_mozilla_page_load 01:49:22 INFO - PROCESS | 2571 | _x_x_mozilla_page_load_details 01:49:22 INFO - PROCESS | 2571 | |i|pagename|runs| 01:49:22 INFO - PROCESS | 2571 | |0;ai-astar;112;108;111;111;111;111;117;112;112;111 01:49:22 INFO - PROCESS | 2571 | |1;audio-beat-detection;156;122;146;162;118;127;161;149;158;116 01:49:22 INFO - PROCESS | 2571 | |2;audio-dft;187;186;185;189;189;185;235;239;185;183 01:49:22 INFO - PROCESS | 2571 | |3;audio-fft;74;79;85;90;77;82;84;87;77;57 01:49:22 INFO - PROCESS | 2571 | |4;audio-oscillator;92;92;128;78;81;83;143;116;119;121 01:49:22 INFO - PROCESS | 2571 | |5;imaging-gaussian-blur;89;86;91;87;89;86;91;88;90;86 01:49:22 INFO - PROCESS | 2571 | |6;imaging-darkroom;89;129;150;151;94;95;110;128;141;150 01:49:22 INFO - PROCESS | 2571 | |7;imaging-desaturate;87;86;85;84;86;85;85;85;86;86 01:49:22 INFO - PROCESS | 2571 | |8;json-parse-financial;56;55;55;54;54;54;54;63;56;56 01:49:22 INFO - PROCESS | 2571 | |9;json-stringify-tinderbox;65;69;74;79;99;101;101;84;71;69 01:49:22 INFO - PROCESS | 2571 | |10;stanford-crypto-aes;83;82;82;81;84;83;83;81;85;83 01:49:22 INFO - PROCESS | 2571 | |11;stanford-crypto-ccm;122;133;131;120;126;127;129;120;132;119 01:49:22 INFO - PROCESS | 2571 | |12;stanford-crypto-pbkdf2;139;125;143;177;176;158;138;140;139;138 01:49:22 INFO - PROCESS | 2571 | |13;stanford-crypto-sha256-iterative;66;68;69;72;92;95;94;77;67;67 01:49:22 INFO - PROCESS | 2571 | __end_tp_report 01:49:22 INFO - PROCESS | 2571 | __start_cc_report 01:49:22 INFO - PROCESS | 2571 | _x_x_mozilla_cycle_collect,1256 01:49:22 INFO - PROCESS | 2571 | __end_cc_report 01:49:22 INFO - PROCESS | 2571 | __startTimestamp1458204562094__endTimestamp 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | ------- Summary: start ------- 01:49:22 INFO - PROCESS | 2571 | Number of tests: 14 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:2.22 (2.0%) stddev-sans-first:2.35 01:49:22 INFO - PROCESS | 2571 | Values: 112.0 108.0 111.0 111.0 111.0 111.0 117.0 112.0 112.0 111.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:152.50 stddev:18.72 (12.3%) stddev-sans-first:19.10 01:49:22 INFO - PROCESS | 2571 | Values: 156.0 122.0 146.0 162.0 118.0 127.0 161.0 149.0 158.0 116.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#2] audio-dft Cycles:10 Average:196.30 Median:188.00 stddev:21.55 (11.5%) stddev-sans-first:22.59 01:49:22 INFO - PROCESS | 2571 | Values: 187.0 186.0 185.0 189.0 189.0 185.0 235.0 239.0 185.0 183.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#3] audio-fft Cycles:10 Average:79.20 Median:83.00 stddev:9.26 (11.2%) stddev-sans-first:9.63 01:49:22 INFO - PROCESS | 2571 | Values: 74.0 79.0 85.0 90.0 77.0 82.0 84.0 87.0 77.0 57.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:79.50 stddev:22.78 (28.7%) stddev-sans-first:23.65 01:49:22 INFO - PROCESS | 2571 | Values: 92.0 92.0 128.0 78.0 81.0 83.0 143.0 116.0 119.0 121.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:2.11 01:49:22 INFO - PROCESS | 2571 | Values: 89.0 86.0 91.0 87.0 89.0 86.0 91.0 88.0 90.0 86.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#6] imaging-darkroom Cycles:10 Average:123.70 Median:150.50 stddev:24.88 (16.5%) stddev-sans-first:23.01 01:49:22 INFO - PROCESS | 2571 | Values: 89.0 129.0 150.0 151.0 94.0 95.0 110.0 128.0 141.0 150.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 01:49:22 INFO - PROCESS | 2571 | Values: 87.0 86.0 85.0 84.0 86.0 85.0 85.0 85.0 86.0 86.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.71 (4.9%) stddev-sans-first:2.87 01:49:22 INFO - PROCESS | 2571 | Values: 56.0 55.0 55.0 54.0 54.0 54.0 54.0 63.0 56.0 56.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:72.50 stddev:14.26 (19.7%) stddev-sans-first:13.87 01:49:22 INFO - PROCESS | 2571 | Values: 65.0 69.0 74.0 79.0 99.0 101.0 101.0 84.0 71.0 69.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 01:49:22 INFO - PROCESS | 2571 | Values: 83.0 82.0 82.0 81.0 84.0 83.0 83.0 81.0 85.0 83.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:128.00 stddev:5.34 (4.2%) stddev-sans-first:5.48 01:49:22 INFO - PROCESS | 2571 | Values: 122.0 133.0 131.0 120.0 126.0 127.0 129.0 120.0 132.0 119.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:141.50 stddev:17.32 (12.2%) stddev-sans-first:18.11 01:49:22 INFO - PROCESS | 2571 | Values: 139.0 125.0 143.0 177.0 176.0 158.0 138.0 140.0 139.0 138.0 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - PROCESS | 2571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:74.50 stddev:12.15 (16.3%) stddev-sans-first:12.25 01:49:22 INFO - PROCESS | 2571 | Values: 66.0 68.0 69.0 72.0 92.0 95.0 94.0 77.0 67.0 67.0 01:49:22 INFO - PROCESS | 2571 | -------- Summary: end -------- 01:49:22 INFO - PROCESS | 2571 | 01:49:22 INFO - TEST-INFO | 2571: exit 0 01:49:22 INFO - TEST-OK | kraken | took 57841ms 01:49:22 INFO - SUITE-END | took 1172s 01:49:23 INFO - Completed test suite (00:19:32) 01:49:23 INFO - javascript benchmark 01:49:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3384.6276909539947, 3432.794032358057, 3434.793912365257, 3445.483177523371, 3501.7023552997994, 5474.698891560963, 5582.720863956806, 5602.047651899176, 5630.634008789426, 5652.293463317091, 4182.0, 5425.02349577076, 5629.437056294359, 5634.0, 5791.420857914207, 5051.9494805051845, 5066.771995260204, 5085.567726743213, 5089.211172268304, 5206.323177986876, 5172.353455818023, 5175.482451754832, 5196.220566914955, 5213.843584692465, 5262.657927234717, 5027.622928280357, 5028.969061342416, 5134.127198376285, 5137.486251374851, 5141.971605678842, 5134.897302053938, 5143.254228136937, 5154.175331946871, 5162.793488260465, 5163.122269214243, 5084.211947148198, 5125.974370128126, 5132.589392848563, 5138.691678499302, 5138.922916156261, 5403.108487099624, 5492.203630473599, 5508.9724551376985, 5512.062949298629, 5597.74810133545, 5150.459201783834, 6021.548383871227, 6033.42682445167, 6119.84700382494, 6134.9079763803575, 6189.597676151036, 6233.407826256498, 6240.656763877985, 6241.531885108635, 6250.499960003189, 5535.114381698909, 5639.15412688096, 5683.9715801420725, 5705.971470142665, 5769.307683077974, 6306.0, 6331.841703957438, 6375.649339286291, 6375.776847810304, 6392.744290228339, 5904.76380944766, 5966.731497082642, 6029.849253768691, 6038.939610603926, 6069.514438844882, 6049.0, 6136.702895113906, 6140.201773769381, 6176.969115154486, 6215.689215539295, 6036.034234522455, 6134.570580059442, 6140.017597184429, 6157.7229024694, 6170.413810687977, 6135.938640613536, 6137.202163718777, 6154.969225153845, 6164.075388691643, 6203.875922481525, 4724.267738500538, 4791.6406269529925, 4823.059503396804, 4830.975845120752, 4832.44426890905, 4360.215161270939, 4404.691671583022, 4409.536998615099, 4410.977945110254, 4419.823207071746, 5496.945030549643, 5515.972420137874, 5535.363433205233, 5544.584156188302, 5559.082751346064, 6100.672006988121, 6104.580421837897, 6122.489639783165, 6132.814448934737, 6208.317085120633, 5566.304211973504, 5569.944300557024, 5575.60970732053, 5590.832275031756, 5604.579656525777, 5279.1817268323475, 5295.802715157554, 5300.992811365905, 5335.253064570963, 5361.624686272002, 6172.814815555541, 6201.441870231701, 6215.223097112951, 6274.278457977391, 6276.309605943251, 6203.2245969253845, 6233.781817636361, 6237.937620623736, 6252.187215661935, 6264.780732674334, 6209.96895015522, 6279.434850863444, 6281.874362512815, 6291.182146320949, 6292.528060395397, 6011.879762404815, 6030.909536357046, 6092.360302168208, 6098.32918378969, 6098.734805259241, 6123.050927106306, 6159.4456498915315, 6160.414760597736, 6167.198264225622, 6174.969125154345, 5043.470435604356, 5776.740046697824, 5890.882182356415, 5973.761049558143, 5974.641521508724, 5999.430054144849, 6015.157877897011, 6026.517878569616, 6026.638401695912, 6078.513718902565, 5825.76696932118, 5929.377415371324, 5934.495567876779, 5938.465538101419, 5953.10703394477, 5861.062230043172, 5943.554233432424, 5975.760969561343, 6031.396860313934, 6139.416755408229, 4902.975485122552, 5771.913421298768, 5805.0, 5857.619254748428, 5864.970675146597], "unit": "score", "name": "dojo.html", "value": 5601.795198512579}, {"lowerIsBetter": false, "replicates": [486.35072178641514, 562.4347530731617, 564.8870225954809, 624.7032659486745, 627.9340669229731, 24699.382515437122, 30571.541426878586, 37769.99999999996, 38440.23119537607, 38577.03557411066, 39871.601283987155, 41491.792541037255, 42082.15835683292, 42088.36867446991, 42142.7892860536, 8682.999999999984, 9618.0, 9640.469774162419, 9644.710658680217, 9645.37305075168, 9429.387089839172, 9610.087041731025, 9619.182369498567, 9641.517924103768, 9655.0, 8423.789405264855, 9662.903370966305, 9707.563159657833, 9745.074217949283, 9757.170640495531, 9628.277879159055, 9715.65995190172, 9733.513324333755, 9737.0, 9750.902490975106, 9531.332806703533, 9661.516924153764, 9665.71002869908, 9671.177949874269, 9671.564779584865, 40295.19409611791, 40743.388849167284, 40782.77651670454, 40812.38781418281, 40893.0, 3143.921401964946, 3165.572647692555, 3176.857041433141, 3625.274945011008, 3639.3267245559655, 27189.728102718916, 29283.414331713248, 29359.2660183495, 29367.2658183545, 29406.0, 2746.231055304518, 2748.8900443982216, 2786.6098746175553, 2863.599096126544, 2874.4682233786607, 500039.0, 505143.0, 505183.0, 505605.0, 505951.99999999633, 44998.0, 64844.67577662082, 66812.0, 66965.0, 67014.0, 38501.6149838498, 46955.765221174355, 47030.589082327584, 47045.5295447048, 47255.05489890183, 12385.876141238472, 12577.559785407468, 15160.620984475476, 15167.469138580318, 15172.165530895685, 12445.688857778447, 12474.625761227178, 12492.437840297209, 12541.686457838627, 12549.811752823714, 14604.707905841824, 14650.926745366205, 14761.55715328542, 14767.187804670846, 14863.702725945637, 6162.876742465215, 6201.627902325875, 6297.716602752887, 6311.968440157862, 6314.62112273265, 923.6397804856111, 964.8311545479513, 966.6660009187276, 994.9950250248847, 1001.9198464122853, 27524.03665871685, 28429.85785071103, 28731.56902646462, 29422.852885735436, 29618.703812962027, 1106.8948449897248, 1133.3709791066037, 1134.9092072634169, 1144.6394385768456, 1146.7649131927935, 14621.561353159423, 14690.559283221306, 14705.55883323502, 15061.924690376478, 15159.469418570297, 522519.0, 522672.0, 527447.0, 529289.0, 530099.0, 58314.0, 58866.41133588695, 58956.41043589595, 58957.0, 59049.40950590525, 1326.2175316563273, 1442.8917831162705, 1456.6576854439197, 1470.7499725046982, 1485.2499487758828, 28158.2960425991, 28418.857905710338, 28844.711552884204, 28910.0, 28972.13083607495, 44963.0, 45454.77272613616, 45775.77112114551, 45853.85365365759, 45916.311255331864, 318802.0, 320064.0, 320475.3976230104, 320479.0, 320847.0, 28157.296067598472, 28604.57093143646, 32145.35709285848, 33213.667863321054, 33264.83367583244, 38464.0, 40394.79802600968, 41324.0, 42131.789341054326, 42197.15605687931, 27843.44313113767, 31989.04032879017, 34551.30897381988, 34930.65069349274, 35446.113847154025, 33966.0, 34297.314053718284, 34486.48270275898, 35309.0, 35404.46893296654, 36200.637993619726, 36612.0, 36710.63289367072, 37319.44020839744, 38464.6153538461, 30594.694053059186, 31521.52717709282, 31589.842050790518, 31628.841855791496, 31697.366052678357, 19849.900750496156, 24011.879940600185, 24451.586139336127, 24571.38571535726, 24947.625785613593], "unit": "score", "name": "ext.html", "value": 18672.76606758919}, {"lowerIsBetter": false, "replicates": [355.6141586378779, 356.44572689467884, 359.29578027066964, 367.8289595338167, 369.9778013319199, 19600.215991360346, 19757.802421975775, 20576.89711551444, 20619.690704639423, 20636.1745530179, 19521.12154953027, 20054.065127992435, 20562.89718551405, 20596.588068238627, 20881.373558793224, 5837.09525023622, 6046.062860256645, 6064.666443345614, 6069.15031895535, 6079.0, 4190.308599081163, 4491.550844915499, 5472.945270547303, 5955.076963070731, 6568.146141001663, 6324.083007963843, 6528.869422611545, 6566.5075119366, 6578.0, 6580.111684922546, 6260.843478913018, 6422.550421470499, 6493.772717954849, 6496.155499785022, 6506.577072490297, 5559.805406810742, 5574.526165275956, 5574.749136288877, 5576.86057848553, 5584.553235741131, 25205.0, 25439.0, 25700.831800367778, 25749.841257143285, 25867.482650347076, 1786.4908501077261, 2040.9183632654676, 2080.147139672727, 2202.876532968182, 2207.70196023538, 14075.155490670593, 14274.714505709828, 14610.70778584433, 14894.404223831034, 14915.627109322353, 1579.5656194546477, 1723.758673785671, 1758.5867321179512, 1819.7634307540068, 1829.3597240965555, 95725.0, 98197.50901245448, 98501.99999999929, 99194.50402748013, 100889.0, 10241.590336386462, 10370.0, 10629.73425664349, 10632.681019569425, 10745.24783265164, 12744.0, 12800.0, 12819.16675416095, 12855.678608034874, 12867.356632168354, 8358.791030224293, 8522.403431759842, 8535.573221338907, 8627.439216451035, 8627.568621568897, 8721.825563488695, 8726.389152759246, 8728.519931403835, 8817.559122043873, 8853.69012084574, 5598.664080155204, 5901.557383196192, 6161.537884658668, 6221.844453888599, 6245.781397651061, 1557.9454719084777, 1770.530809335527, 1802.152988095593, 1802.5493626593352, 1807.2319264312614, 891.8795962545103, 901.9098090190928, 946.8911075226437, 1007.1036777268237, 1057.9259451838452, 19840.404787856387, 20704.48238794042, 20727.8963605181, 20830.89584552098, 21001.579968400547, 952.7570469530225, 975.1857199238574, 980.9901900981041, 997.2719914462338, 1023.0843395161438, 10855.0, 11289.122761471652, 11300.875180559036, 11311.0, 11361.431928403546, 632427.0, 655253.0, 655722.0, 669228.0, 673708.0, 70995.0, 73377.0, 75931.62034189794, 91169.0, 91924.0, 980.8773903262235, 1023.1610079734695, 1034.6533911139702, 1062.5484169228048, 1068.423051552153, 13688.863111368759, 17738.201780920146, 17881.46355609334, 17958.461246162635, 18512.907435462737, 39351.80324098476, 50259.49740502548, 50673.0, 51677.0, 52304.47695523148, 71518.0, 71611.64194178996, 74384.62807685927, 74495.0, 76701.23298767164, 6548.8035358939305, 7305.525140865827, 7553.169151393233, 7655.846883062419, 7859.764207073797, 10700.678979630313, 11917.642470725892, 11938.940305298418, 12044.277343359427, 12208.32854193028, 10416.0, 10498.947505262426, 10681.03870651645, 10699.197560183173, 10836.458177091272, 10210.43842588635, 10319.174466042849, 10379.636712715019, 10573.788524229318, 10683.786324273315, 7936.738029661749, 10778.89221107779, 10867.0, 11122.944385278022, 11136.610218642309, 7373.410127189919, 7404.592747398945, 7626.771196864103, 7720.112187098555, 7867.331276841303, 9354.532273386167, 9854.0, 10570.402277435907, 10802.459877005962, 10911.0], "unit": "score", "name": "jquery.html", "value": 9357.451124023257}, {"lowerIsBetter": false, "replicates": [1458.934347954342, 1612.226131456901, 1640.745684418915, 1922.6154769046195, 2045.4477291131395, 7844.019497562805, 8561.315094792417, 8722.86915696265, 8731.170538798811, 8754.95622521888, 8423.663053477854, 8675.219230269275, 8680.218780309771, 8689.73930782076, 8695.17395847395, 2153.9784602153936, 2436.7806897379232, 2459.360566252774, 2488.4525404411, 2492.4890397468475, 2496.962545561818, 2505.8621775802417, 2507.4608959073794, 2510.585753350704, 2514.5473814713346, 2431.2827715823787, 2459.139301244559, 2463.987680061597, 2477.8389404688637, 2481.0, 2435.8538487690794, 2458.9016439342404, 2466.90132394704, 2474.406142525781, 2476.0838489758903, 2426.1265944260053, 2451.301379106964, 2477.6035834266613, 2478.8512689238523, 2492.7507249274927, 8399.874001889977, 8749.650013999433, 8798.0, 8808.207261346446, 8841.60212790426, 4887.633427492952, 5481.808136715196, 5543.6119471637, 5545.667259964415, 5547.667139971614, 3597.262561174979, 3683.9815800920824, 3748.137928276484, 3752.962470375316, 3763.9623603763885, 1055.7044027672264, 1069.2408390043079, 1076.94615269237, 1083.8374243863404, 1084.7450849050467, 11792.174547781744, 11890.88109118915, 11933.045356371556, 11944.104192185534, 11945.283283003047, 4817.108834865561, 4857.975710121426, 4934.827281045146, 4950.5544500994365, 4970.676906001098, 9988.60045598168, 9993.40039597612, 10018.599256029824, 10041.548130334153, 10046.29675922693, 5441.863953401117, 5472.5621950243885, 5483.835484935458, 5488.670679759227, 5491.0, 4375.343698445258, 4512.029913568598, 4784.234522476457, 4913.508649135058, 4966.106100901872, 3841.6158384161918, 3915.882523524299, 3921.8627348042683, 3944.0928586425284, 3962.2867883781196, 1309.3256972659087, 1317.8682131786745, 1322.814805927171, 1331.6071758831167, 1333.113479536117, 1335.5258883096556, 1349.2444231230543, 1363.3047145955634, 1416.2564653556758, 1424.9358778854976, 8179.427440079137, 8193.754187374388, 8198.344132469389, 8202.876956845652, 8231.506109633441, 508.8041104174919, 523.5183631059434, 523.7512181713655, 524.1247117314094, 529.4255732530248, 6195.690215489208, 6215.316315205324, 6221.097940798559, 6226.066090086432, 6251.9687401562705, 10385.896141038493, 10615.681529554126, 10703.304285221435, 10722.517486713117, 10739.14086873064, 10333.173346132442, 10451.16390688743, 10536.736581585521, 10558.472076396149, 10578.418186999636, 8279.420440569102, 8336.333093352518, 8350.290225330793, 8370.246677799027, 8378.287845533076, 6281.96859015702, 7627.733029343946, 7861.52830830152, 7884.526928384315, 7895.0, 7268.345848873627, 9406.0, 9535.952320238632, 9589.753332066786, 9642.180414664552, 9661.227101831695, 9789.510524473606, 9939.552720127756, 9945.701628951143, 10083.949580252052, 6743.561668491532, 6940.479464040116, 7172.211056783854, 7493.775186744407, 7558.848823023399, 8160.30637395828, 8201.671933122609, 8223.712170074019, 8234.876476852973, 8240.917590824254, 7236.38490728294, 7281.854362912606, 7318.048653674989, 7431.591262480615, 7458.03045604068, 7182.712691492282, 7239.855202895807, 7255.165655949633, 7333.413326933939, 7350.411967042517, 7636.007319048488, 7712.190220026816, 7717.961410192913, 7718.961405192938, 7731.304182623591, 6912.274211207952, 6936.41040511542, 7017.473689473208, 7022.929770702228, 7039.1553013638695, 7067.929320706727, 7145.606991615303, 7157.642117894188, 7158.284171583008, 7165.283471652793], "unit": "score", "name": "mootools.html", "value": 4846.260512887513}, {"lowerIsBetter": false, "replicates": [323.2968293960636, 326.3701056960066, 331.71141107236707, 333.21029160888696, 336.83495087407175, 6443.903341449876, 6491.772787952423, 6551.541392102555, 6582.308857569946, 6590.934090659098, 6448.322926092751, 6475.255345635242, 6488.448481879046, 6513.38122878327, 6520.902186467207, 4624.606908412789, 4692.835750748724, 4756.1914474539235, 4801.375821143247, 4869.001854619803, 4760.3573517575205, 4772.57046865782, 4792.760361981905, 4805.783739731721, 4812.398450193726, 4740.170470167707, 4760.428748550162, 4761.309610106549, 4762.238041913294, 4769.499202583731, 4555.977220113895, 4672.182368085605, 4775.42694876617, 4777.355057067286, 4778.259369797687, 4111.814968326403, 4113.91772164555, 4114.7119701620895, 4121.670266378683, 4122.361034039729, 5529.502344788948, 6120.540959428061, 6146.5390095743, 6214.627122372672, 6235.251769787655, 5587.273654424939, 5588.804391846306, 5591.916121258185, 5597.496225339739, 5615.859603509904, 6894.620795856226, 6898.482613803934, 6899.689513971884, 6914.135733033371, 6923.065386172852, 3726.273376691546, 4283.121959998193, 4489.73061616304, 4495.078508905666, 4497.572730590588, 5894.027485464893, 7165.211826699111, 7296.343329100353, 7305.926940730577, 7320.26797320269, 4558.111168322212, 4561.954380456219, 4563.315502674625, 4563.520830312769, 4563.885902852388, 4613.95386046142, 4623.42207224097, 4637.420322459692, 4637.86086417408, 4642.489326174118, 5462.8361149165585, 5467.17992301158, 5473.67157970523, 5480.80817171405, 5481.835544933659, 6682.565633233824, 6897.586144831326, 6903.6548172591165, 6961.26906674802, 6979.755708550177, 1578.2976575424057, 1591.0135715856243, 1600.6158521954646, 1601.3114360824957, 1605.0, 958.7698952251549, 987.1263931420744, 1007.8740157480315, 1012.0739523336065, 1041.3075304922143, 5358.0, 6373.52198585108, 6431.5819471734185, 6451.806445806634, 6506.902396464056, 7162.7493037743425, 7242.275772422716, 7244.963775181091, 7258.528195667371, 7263.128424589083, 6422.710978006001, 6431.839204019937, 6436.034594810816, 6441.5490915635455, 6464.644444555594, 3084.306031142975, 3654.6162652921594, 3787.905302367463, 3830.4254361845387, 3832.2527107213828, 6584.967075164594, 7124.536905101256, 7258.709651613982, 7558.168601453835, 7569.470137090461, 7419.554826710415, 7457.291557302047, 7468.506298740273, 7474.103107627119, 7475.8504829903095, 7519.73680921187, 7532.246775322534, 7534.284242996797, 7542.358899493604, 7572.39420846331, 6888.173419189528, 7181.784546463406, 7185.425165986813, 7191.568505889663, 7202.207757146814, 6764.797056088325, 7014.0531028310525, 7115.039469671735, 7125.608091555015, 7148.4281257500315, 6229.190205273286, 7557.659905304165, 7561.3194812467145, 7566.432517561095, 7578.74114130929, 4713.858584242478, 4757.952420475751, 4764.4282686077895, 4765.571098601143, 4767.73777442244, 5742.0, 7111.6799744010605, 7112.35988761014, 7112.893306600508, 7115.430765538641, 5298.788048478018, 6893.7931862044215, 6895.862082758216, 6916.446684265146, 6932.2721114284295, 6862.0, 6874.65626718652, 6893.069435626327, 6896.655167241718, 6902.723891044302, 5438.945610543844, 6715.664216789239, 6715.731370745116, 6726.192856857208, 6733.6296503692765, 6654.101696270942, 6865.176178858569, 6880.174379074543, 6899.379055884994, 6919.37725604698, 6624.105745724266, 6643.269240383651, 6725.092112564741, 6731.0, 6800.693968771516], "unit": "score", "name": "prototype.html", "value": 5030.268448879295}, {"lowerIsBetter": false, "replicates": [679.9116114905062, 698.6925752668825, 714.7998560403089, 767.7543186180421, 809.4414853750914, 15094.77357839632, 15295.541133765977, 15307.005044672089, 15314.92342538287, 15380.846191538081, 14094.154350738963, 14119.364628591713, 14203.218822964758, 14358.923080768958, 14398.640033999156, 905.4069584422214, 915.9221466175383, 930.2836815651943, 930.6603089872182, 930.9906900931005, 744.7636922708306, 758.7913323835961, 915.199200699388, 926.3978414030867, 938.0010289042183, 983.0366241083742, 983.5770618633984, 986.0533887468004, 988.9456079915602, 990.4305024610842, 981.470006196653, 983.945882976436, 984.5963155106443, 984.8227319082562, 984.8621193032981, 575.9078547432391, 715.8103102677794, 721.6896734404204, 723.1864152828068, 724.9673764680549, 14285.357183923878, 14432.20622865742, 15232.086074835435, 15330.386784528606, 15417.460388886335, 12769.361531923367, 12791.232526048467, 13002.934985325108, 13027.478900843955, 13142.802857957138, 10081.949590252076, 10145.695629131063, 10241.795164096751, 10315.742106447324, 10553.630622928238, 3481.234128491728, 3575.5173051637958, 3632.945505817415, 3650.379435495972, 3662.5421822272215, 82447.7632835508, 82718.17281827165, 83130.58434707849, 85308.0, 85729.0, 8951.478248697736, 8966.641334346683, 9064.954675226581, 9524.330343826525, 9595.568199431042, 22496.32511024672, 22613.88693056557, 22616.773832261795, 22634.320970370914, 22639.981200845672, 7390.0, 7489.588072655947, 7524.887126693104, 7574.431917606092, 7733.806654833562, 3971.205758848242, 4018.718689691752, 4020.3165461871554, 4027.91944161121, 4038.1519880825354, 3646.3801153803915, 3654.780713157166, 3696.815159242027, 3698.5561732591723, 3709.629037096323, 669.0332469581408, 693.2547511425238, 708.1360739897317, 713.13710410404, 728.7667946257253, 411.33774622857175, 511.33015749368445, 543.7987944460575, 567.9318481782212, 590.893639144958, 7915.722949696733, 7994.5602991836, 8059.43583949118, 8148.959255203686, 8192.426530142951, 525.8606469285643, 534.8662834291428, 599.9070144127667, 607.4381197392395, 609.8841220168242, 3575.800882457322, 3626.709863210937, 3808.21931504041, 3883.1845312484693, 3973.5033120859894, 97017.0, 97838.0, 99367.50316248517, 100294.0, 101210.49394753126, 63309.0, 83490.5825470881, 83537.0, 84619.15380846236, 84981.57509212414, 68449.65775171191, 69052.65473672599, 69528.65235673789, 69759.99999999898, 70751.64624176847, 6348.143000694847, 6388.137601423934, 7414.777556673308, 7540.132884718328, 7845.529268243924, 50345.74827125841, 50997.0, 51149.48850511596, 51321.0, 51500.0, 70972.0, 71441.92837107343, 71462.57074858577, 71513.6424317875, 71943.56112877608, 10007.299489035697, 10048.799024019625, 10199.337043092175, 10317.17462602975, 10522.0, 11025.228234023542, 11160.386178760245, 11306.434678265889, 11345.376004319842, 11732.648020559396, 9920.900790991998, 9945.602175912882, 9960.053794889474, 10020.69937901864, 10295.17638588896, 8673.913260867563, 10029.849552256575, 10599.258051936291, 10599.947000264949, 10678.62624808128, 8391.58042097905, 9889.950550247491, 9903.158231550111, 10274.434906080238, 10277.9486102569, 8698.43460175112, 8735.78160545966, 8776.824463510822, 8813.0, 8993.055729148346, 8092.635831387484, 8353.665853365797, 8359.247667709935, 8489.74530764078, 8604.526751028754], "unit": "score", "name": "yui.html", "value": 6799.004178602715}], "name": "dromaeo_css", "value": 7385.1923204096765}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 111.0, 111.0, 117.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 146.0, 162.0, 118.0, 127.0, 161.0, 149.0, 158.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 185.0, 189.0, 189.0, 185.0, 235.0, 239.0, 185.0, 183.0], "unit": "score", "name": "audio-dft", "value": 196.3}, {"lowerIsBetter": true, "replicates": [74.0, 79.0, 85.0, 90.0, 77.0, 82.0, 84.0, 87.0, 77.0, 57.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 128.0, 78.0, 81.0, 83.0, 143.0, 116.0, 119.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 91.0, 87.0, 89.0, 86.0, 91.0, 88.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.3}, {"lowerIsBetter": true, "replicates": [89.0, 129.0, 150.0, 151.0, 94.0, 95.0, 110.0, 128.0, 141.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 123.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 85.0, 84.0, 86.0, 85.0, 85.0, 85.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 74.0, 79.0, 99.0, 101.0, 101.0, 84.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.2}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 81.0, 84.0, 83.0, 83.0, 81.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [122.0, 133.0, 131.0, 120.0, 126.0, 127.0, 129.0, 120.0, 132.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [139.0, 125.0, 143.0, 177.0, 176.0, 158.0, 138.0, 140.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 69.0, 72.0, 92.0, 95.0, 94.0, 77.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.7}], "name": "kraken", "value": 1500.9}]} 01:49:23 INFO - Return code: 0 01:49:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:49:23 ERROR - # TBPL SUCCESS # 01:49:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:23 INFO - 2016-03-17 01:49:23.419 screenresolution[2575:21620] starting screenresolution argv=screenresolution get 01:49:23 INFO - 2016-03-17 01:49:23.421 screenresolution[2575:21620] Display 0: 1600x1200x32@60 01:49:23 INFO - 2016-03-17 01:49:23.427 screenresolution[2576:21623] starting screenresolution argv=screenresolution list 01:49:23 INFO - Available Modes on Display 0 01:49:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:23 INFO - Intel Iris: 01:49:23 INFO - Chipset Model: Intel Iris 01:49:23 INFO - Type: GPU 01:49:23 INFO - Bus: Built-In 01:49:23 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:23 INFO - Vendor: Intel (0x8086) 01:49:23 INFO - Device ID: 0x0a2e 01:49:23 INFO - Revision ID: 0x0009 01:49:23 INFO - Displays: 01:49:23 INFO - Display: 01:49:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:23 INFO - Display Serial Number: 1600x1200 60 01:49:23 INFO - Main Display: Yes 01:49:23 INFO - Mirror: Off 01:49:23 INFO - Online: Yes 01:49:23 INFO - Rotation: Supported 01:49:23 INFO - Return code: 0 01:49:23 INFO - Running post-action listener: _resource_record_post_action 01:49:23 INFO - Running post-run listener: _resource_record_post_run 01:49:24 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 471040; Write bytes: 702653440; Read time: 8; Write time: 1991 01:49:24 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384860672; Write bytes: 379234304; Read time: 29533; Write time: 658 01:49:24 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 471040; Write bytes: 298511360; Read time: 8; Write time: 1284 01:49:24 INFO - Running post-run listener: _upload_blobber_files 01:49:24 INFO - Blob upload gear active. 01:49:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:49:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:49:25 INFO - (blobuploader) - INFO - Open directory for files ... 01:49:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:49:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:49:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:49:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:49:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:49:26 INFO - (blobuploader) - INFO - Done attempting. 01:49:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:49:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:49:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:49:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:49:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:49:28 INFO - (blobuploader) - INFO - Done attempting. 01:49:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:49:28 INFO - Return code: 0 01:49:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:49:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:49:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4e34c460601ab87b6e791710c6ce5aef6cd4aa8dd213120a0de6080754bcdcf7380d55c2147f9c23bc744f09c7c2367654d2693e93f55859831965ada9f6184", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56a357bd931e6e4d100497e17d09ff5eafdc47be01d6674c73f2a34e52bcc6eed416705d81db1d04ba922666bbbbadedf83328b8b4ebde3fd2ef5419d34422e0"} 01:49:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:49:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:49:28 INFO - Contents: 01:49:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4e34c460601ab87b6e791710c6ce5aef6cd4aa8dd213120a0de6080754bcdcf7380d55c2147f9c23bc744f09c7c2367654d2693e93f55859831965ada9f6184", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56a357bd931e6e4d100497e17d09ff5eafdc47be01d6674c73f2a34e52bcc6eed416705d81db1d04ba922666bbbbadedf83328b8b4ebde3fd2ef5419d34422e0"} 01:49:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:49:28 INFO - Copying logs to upload dir... 01:49:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:49:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.373001 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-17 01:49:28.549313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 01:49:28.554278) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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/b4e34c460601ab87b6e791710c6ce5aef6cd4aa8dd213120a0de6080754bcdcf7380d55c2147f9c23bc744f09c7c2367654d2693e93f55859831965ada9f6184", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56a357bd931e6e4d100497e17d09ff5eafdc47be01d6674c73f2a34e52bcc6eed416705d81db1d04ba922666bbbbadedf83328b8b4ebde3fd2ef5419d34422e0"} build_url:https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/bP_S0WssQYO8O_XJrEF5YA/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/b4e34c460601ab87b6e791710c6ce5aef6cd4aa8dd213120a0de6080754bcdcf7380d55c2147f9c23bc744f09c7c2367654d2693e93f55859831965ada9f6184", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/56a357bd931e6e4d100497e17d09ff5eafdc47be01d6674c73f2a34e52bcc6eed416705d81db1d04ba922666bbbbadedf83328b8b4ebde3fd2ef5419d34422e0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 01:49:28.597685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:49:28.598035) ========= 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.GKVlwzhZOe/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.41tgwp1yG9/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005048 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 01:49:28.647679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 01:49:28.651034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 01:49:28.651787) ========= ========= Total master_lag: 4.83 =========