builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0089 starttime: 1459329250.68 results: success (0) buildid: 20160330002037 builduid: 5d59c23dcac8483aa02d002e6696e608 revision: 85d231a303cfe702634035ae2470e343842e9e21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.678807) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.679178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.679458) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005769 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.740538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.740817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.868829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.869082) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005405 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.918084) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.918362) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.918693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:10.918967) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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-30 02:14:10-- 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-30 02:14:11 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:11.057105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:11.057387) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.019417 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:11.114066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 02:14:11.114375) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 85d231a303cfe702634035ae2470e343842e9e21 --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 85d231a303cfe702634035ae2470e343842e9e21 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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-30 02:14:11,221 truncating revision to first 12 chars 2016-03-30 02:14:11,221 Setting DEBUG logging. 2016-03-30 02:14:11,222 attempt 1/10 2016-03-30 02:14:11,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/85d231a303cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 02:14:12,344 unpacking tar archive at: fx-team-85d231a303cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367602 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 02:14:12.501324) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:12.501944) ========= echo 85d231a303cfe702634035ae2470e343842e9e21 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'85d231a303cfe702634035ae2470e343842e9e21'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 85d231a303cfe702634035ae2470e343842e9e21 program finished with exit code 0 elapsedTime=0.005170 script_repo_revision: '85d231a303cfe702634035ae2470e343842e9e21' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:12.556929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:12.557669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 02:14:12.577458) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-03-30 02:14:12.577785) ========= /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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:14:12 INFO - MultiFileLogger online at 20160330 02:14:12 in /builds/slave/test 02:14:12 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 02:14:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:14:12 INFO - {'append_to_log': False, 02:14:12 INFO - 'base_work_dir': '/builds/slave/test', 02:14:12 INFO - 'blob_upload_branch': 'Fx-Team', 02:14:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:14:12 INFO - 'branch': 'Fx-Team', 02:14:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:14:12 INFO - 'config_files': ('talos/mac_config.py',), 02:14:12 INFO - 'default_actions': ('clobber', 02:14:12 INFO - 'read-buildbot-config', 02:14:12 INFO - 'download-and-extract', 02:14:12 INFO - 'populate-webroot', 02:14:12 INFO - 'create-virtualenv', 02:14:12 INFO - 'install', 02:14:12 INFO - 'run-tests'), 02:14:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:14:12 INFO - 'download_minidump_stackwalk': True, 02:14:12 INFO - 'download_symbols': 'ondemand', 02:14:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:14:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:14:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:14:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:14:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:14:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:14:12 INFO - 'installer_path': 'installer.exe', 02:14:12 INFO - 'log_level': 'info', 02:14:12 INFO - 'log_name': 'talos', 02:14:12 INFO - 'log_to_console': True, 02:14:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:14:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:14:12 INFO - 'opt_config_files': (), 02:14:12 INFO - 'pip_index': False, 02:14:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:14:12 INFO - 'cmd': ('bash', 02:14:12 INFO - '-c', 02:14:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:14:12 INFO - 'enabled': True, 02:14:12 INFO - 'halt_on_failure': False, 02:14:12 INFO - 'name': 'check_screen_resolution'},), 02:14:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:14:12 INFO - 'cmd': ('bash', 02:14:12 INFO - '-c', 02:14:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:14:12 INFO - 'enabled': True, 02:14:12 INFO - 'halt_on_failure': False, 02:14:12 INFO - 'name': 'check_screen_resolution'},), 02:14:12 INFO - 'run_cmd_checks_enabled': True, 02:14:12 INFO - 'sps_profile': False, 02:14:12 INFO - 'sps_profile_interval': 0, 02:14:12 INFO - 'suite': 'dromaeojs', 02:14:12 INFO - 'system_bits': '32', 02:14:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:14:12 INFO - 'title': 't-yosemite-r7-0089', 02:14:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:14:12 INFO - 'use_talos_json': True, 02:14:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:14:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:14:12 INFO - 'work_dir': 'build'} 02:14:12 INFO - ##### 02:14:12 INFO - ##### Running clobber step. 02:14:12 INFO - ##### 02:14:12 INFO - Running pre-action listener: _resource_record_pre_action 02:14:12 INFO - Running main action method: clobber 02:14:12 INFO - rmtree: /builds/slave/test/build 02:14:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:14 INFO - Running post-action listener: _resource_record_post_action 02:14:14 INFO - ##### 02:14:14 INFO - ##### Running read-buildbot-config step. 02:14:14 INFO - ##### 02:14:14 INFO - Running pre-action listener: _resource_record_pre_action 02:14:14 INFO - Running main action method: read_buildbot_config 02:14:14 INFO - Using buildbot properties: 02:14:14 INFO - { 02:14:14 INFO - "project": "", 02:14:14 INFO - "product": "firefox", 02:14:14 INFO - "script_repo_revision": "production", 02:14:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:14:14 INFO - "repository": "", 02:14:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:14:14 INFO - "buildid": "20160330002037", 02:14:14 INFO - "pgo_build": "False", 02:14:14 INFO - "basedir": "/builds/slave/test", 02:14:14 INFO - "buildnumber": 580, 02:14:14 INFO - "slavename": "t-yosemite-r7-0089", 02:14:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:14:14 INFO - "platform": "yosemite_r7", 02:14:14 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:14:14 INFO - "branch": "fx-team", 02:14:14 INFO - "repo_path": "integration/fx-team", 02:14:14 INFO - "revision": "85d231a303cfe702634035ae2470e343842e9e21", 02:14:14 INFO - "stage_platform": "macosx64", 02:14:14 INFO - "builduid": "5d59c23dcac8483aa02d002e6696e608", 02:14:14 INFO - "slavebuilddir": "test" 02:14:14 INFO - } 02:14:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:14:14 INFO - Running post-action listener: _resource_record_post_action 02:14:14 INFO - ##### 02:14:14 INFO - ##### Running download-and-extract step. 02:14:14 INFO - ##### 02:14:14 INFO - Running pre-action listener: _resource_record_pre_action 02:14:14 INFO - Running main action method: download_and_extract 02:14:14 INFO - mkdir: /builds/slave/test/build/tests 02:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:14 INFO - https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:14:38 INFO - Downloaded 1199 bytes. 02:14:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:14:38 INFO - Using the following test package requirements: 02:14:38 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:14:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:14:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:14:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'jsshell-mac.zip'], 02:14:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:14:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:14:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:14:38 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:14:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:14:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:14:38 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:14:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:38 INFO - https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:14:52 INFO - Downloaded 17946690 bytes. 02:14:52 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'] 02:14:52 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 02:14:55 INFO - Return code: 0 02:14:55 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 02:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:55 INFO - https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:14:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:14:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:14:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:14:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:15:00 INFO - Downloaded 17946690 bytes. 02:15:00 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'] 02:15:00 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 02:15:03 INFO - Return code: 0 02:15:03 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')]} 02:15:03 INFO - https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:15:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:15:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:15:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:15:10 INFO - Downloaded 10847531 bytes. 02:15:10 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'] 02:15:10 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 02:15:10 INFO - Return code: 0 02:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:10 INFO - https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BWm8_MdER72OixuEticsCQ/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 02:15:16 INFO - Downloaded 111429224 bytes. 02:15:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:15:16 INFO - mkdir: /builds/slave/test/properties 02:15:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:15:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:15:16 INFO - Contents: 02:15:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:15:17 INFO - Running post-action listener: _resource_record_post_action 02:15:17 INFO - Running post-action listener: set_extra_try_arguments 02:15:17 INFO - ##### 02:15:17 INFO - ##### Running populate-webroot step. 02:15:17 INFO - ##### 02:15:17 INFO - Running pre-action listener: _resource_record_pre_action 02:15:17 INFO - Running main action method: populate_webroot 02:15:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:17 INFO - '--tppagecycles', 02:15:17 INFO - '7'], 02:15:17 INFO - 'tests': ['tsvgm']}}, 02:15:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:15:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:15:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'tests': ['damp', 'tps']}, 02:15:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['damp', 'tps']}, 02:15:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:15:17 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['dromaeo_dom']}, 02:15:17 INFO - 'other': {'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'other_l64': {'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'other_nol64': {'tests': ['a11yr', 02:15:17 INFO - 'ts_paint', 02:15:17 INFO - 'tpaint', 02:15:17 INFO - 'sessionrestore', 02:15:17 INFO - 'sessionrestore_no_auto_restore', 02:15:17 INFO - 'tabpaint']}, 02:15:17 INFO - 'svgr': {'tests': ['tsvgx', 02:15:17 INFO - 'tsvgr_opacity', 02:15:17 INFO - 'tart', 02:15:17 INFO - 'tscrollx', 02:15:17 INFO - 'cart']}, 02:15:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['tsvgx', 02:15:17 INFO - 'tsvgr_opacity', 02:15:17 INFO - 'tart', 02:15:17 INFO - 'tscrollx', 02:15:17 INFO - 'cart']}, 02:15:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'tests': ['tp5o']}, 02:15:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'talos_options': ['--e10s'], 02:15:17 INFO - 'tests': ['tp5o']}, 02:15:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'talos_options': ['--xperf_path', 02:15:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:17 INFO - 'tests': ['tp5n']}, 02:15:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:17 INFO - 'talos_options': ['--e10s', 02:15:17 INFO - '--xperf_path', 02:15:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:17 INFO - 'tests': ['tp5n']}}, 02:15:17 INFO - 'talos.zip': {'path': '', 02:15:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:17 INFO - Running post-action listener: _resource_record_post_action 02:15:17 INFO - ##### 02:15:17 INFO - ##### Running create-virtualenv step. 02:15:17 INFO - ##### 02:15:17 INFO - Running pre-action listener: _resource_record_pre_action 02:15:17 INFO - Running main action method: create_virtualenv 02:15:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:15:17 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 02:15:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:15:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:17 INFO - Using real prefix '/tools/python27' 02:15:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:15:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:21 INFO - Installing pip.................done. 02:15:21 INFO - Return code: 0 02:15:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:22 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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:22 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 02:15:22 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 02:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:22 INFO - 'HOME': '/Users/cltbld', 02:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:22 INFO - 'LOGNAME': 'cltbld', 02:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:22 INFO - 'MOZ_NO_REMOTE': '1', 02:15:22 INFO - 'NO_EM_RESTART': '1', 02:15:22 INFO - 'PAGER': '/bin/cat', 02:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:22 INFO - 'PWD': '/builds/slave/test', 02:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:22 INFO - 'SHELL': '/bin/bash', 02:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:22 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:22 INFO - 'USER': 'cltbld', 02:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:22 INFO - 'XPC_FLAGS': '0x0', 02:15:22 INFO - 'XPC_SERVICE_NAME': '0', 02:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:22 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 02:15:22 INFO - Cleaning up... 02:15:22 INFO - Return code: 0 02:15:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:22 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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:22 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 02:15:22 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 02:15:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:22 INFO - 'HOME': '/Users/cltbld', 02:15:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:22 INFO - 'LOGNAME': 'cltbld', 02:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:22 INFO - 'MOZ_NO_REMOTE': '1', 02:15:22 INFO - 'NO_EM_RESTART': '1', 02:15:22 INFO - 'PAGER': '/bin/cat', 02:15:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:22 INFO - 'PWD': '/builds/slave/test', 02:15:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:22 INFO - 'SHELL': '/bin/bash', 02:15:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:22 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:22 INFO - 'USER': 'cltbld', 02:15:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:22 INFO - 'XPC_FLAGS': '0x0', 02:15:22 INFO - 'XPC_SERVICE_NAME': '0', 02:15:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:22 INFO - Downloading/unpacking psutil>=0.7.1 02:15:22 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 02:15:22 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 02:15:22 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 02:15:22 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 02:15:22 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 02:15:22 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 02:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:28 INFO - Installing collected packages: psutil 02:15:28 INFO - Running setup.py install for psutil 02:15:28 INFO - building 'psutil._psutil_osx' extension 02:15:28 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 02:15:29 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 02:15:29 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 02:15:29 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 02:15:29 INFO - building 'psutil._psutil_posix' extension 02:15:29 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 02:15:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:15:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:15:29 INFO - ^ 02:15:29 INFO - 1 warning generated. 02:15:29 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 02:15:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:29 INFO - Successfully installed psutil 02:15:29 INFO - Cleaning up... 02:15:29 INFO - Return code: 0 02:15:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:29 INFO - 'HOME': '/Users/cltbld', 02:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:29 INFO - 'LOGNAME': 'cltbld', 02:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:29 INFO - 'MOZ_NO_REMOTE': '1', 02:15:29 INFO - 'NO_EM_RESTART': '1', 02:15:29 INFO - 'PAGER': '/bin/cat', 02:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:29 INFO - 'PWD': '/builds/slave/test', 02:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:29 INFO - 'SHELL': '/bin/bash', 02:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:29 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:29 INFO - 'USER': 'cltbld', 02:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:29 INFO - 'XPC_FLAGS': '0x0', 02:15:29 INFO - 'XPC_SERVICE_NAME': '0', 02:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:15:33 INFO - Installing collected packages: mozsystemmonitor 02:15:33 INFO - Running setup.py install for mozsystemmonitor 02:15:33 INFO - Successfully installed mozsystemmonitor 02:15:33 INFO - Cleaning up... 02:15:33 INFO - Return code: 0 02:15:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:15:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:33 INFO - 'HOME': '/Users/cltbld', 02:15:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:33 INFO - 'LOGNAME': 'cltbld', 02:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:33 INFO - 'MOZ_NO_REMOTE': '1', 02:15:33 INFO - 'NO_EM_RESTART': '1', 02:15:33 INFO - 'PAGER': '/bin/cat', 02:15:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:33 INFO - 'PWD': '/builds/slave/test', 02:15:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:33 INFO - 'SHELL': '/bin/bash', 02:15:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:33 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:33 INFO - 'USER': 'cltbld', 02:15:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:33 INFO - 'XPC_FLAGS': '0x0', 02:15:33 INFO - 'XPC_SERVICE_NAME': '0', 02:15:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15:37 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 02:15:37 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 02:15:37 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 02:15:37 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 02:15:37 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 02:15:37 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 02:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:15:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:38 INFO - Downloading docopt-0.6.1.tar.gz 02:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:38 INFO - Running setup.py install for blobuploader 02:15:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:15:38 INFO - Running setup.py install for requests 02:15:39 INFO - Running setup.py install for docopt 02:15:39 INFO - Successfully installed blobuploader requests docopt 02:15:39 INFO - Cleaning up... 02:15:39 INFO - Return code: 0 02:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:39 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')]} 02:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:39 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')]} 02:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:39 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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:39 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 02:15:39 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 02:15:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:39 INFO - 'HOME': '/Users/cltbld', 02:15:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:39 INFO - 'LOGNAME': 'cltbld', 02:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:39 INFO - 'MOZ_NO_REMOTE': '1', 02:15:39 INFO - 'NO_EM_RESTART': '1', 02:15:39 INFO - 'PAGER': '/bin/cat', 02:15:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:39 INFO - 'PWD': '/builds/slave/test', 02:15:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:39 INFO - 'SHELL': '/bin/bash', 02:15:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:39 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:39 INFO - 'USER': 'cltbld', 02:15:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:39 INFO - 'XPC_FLAGS': '0x0', 02:15:39 INFO - 'XPC_SERVICE_NAME': '0', 02:15:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:39 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-1kTBJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-l5LgiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-NUj9RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Y4I3ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-SZ6fO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-hNwS9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-dLRVO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-1zZBRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-XfZ2Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-a1xKmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:40 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-yefTPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-wtrwI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-kC7yKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-N1l9fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-5dmUX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-UbdGTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:41 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-jsYgXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:15:41 INFO - Running setup.py install for manifestparser 02:15:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:15:41 INFO - Running setup.py install for mozcrash 02:15:42 INFO - Running setup.py install for mozdebug 02:15:42 INFO - Running setup.py install for mozdevice 02:15:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Running setup.py install for mozfile 02:15:42 INFO - Running setup.py install for mozhttpd 02:15:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Running setup.py install for mozinfo 02:15:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Running setup.py install for mozInstall 02:15:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:15:42 INFO - Running setup.py install for mozleak 02:15:43 INFO - Running setup.py install for mozlog 02:15:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Running setup.py install for moznetwork 02:15:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Running setup.py install for mozprocess 02:15:43 INFO - Running setup.py install for mozprofile 02:15:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Running setup.py install for mozrunner 02:15:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:15:43 INFO - Running setup.py install for mozscreenshot 02:15:43 INFO - Running setup.py install for moztest 02:15:44 INFO - Running setup.py install for mozversion 02:15:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:15:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:15:44 INFO - Cleaning up... 02:15:44 INFO - Return code: 0 02:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:44 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 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:44 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 02:15:44 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 02:15:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:44 INFO - 'HOME': '/Users/cltbld', 02:15:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:44 INFO - 'LOGNAME': 'cltbld', 02:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:44 INFO - 'MOZ_NO_REMOTE': '1', 02:15:44 INFO - 'NO_EM_RESTART': '1', 02:15:44 INFO - 'PAGER': '/bin/cat', 02:15:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:44 INFO - 'PWD': '/builds/slave/test', 02:15:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:44 INFO - 'SHELL': '/bin/bash', 02:15:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:44 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:44 INFO - 'USER': 'cltbld', 02:15:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:44 INFO - 'XPC_FLAGS': '0x0', 02:15:44 INFO - 'XPC_SERVICE_NAME': '0', 02:15:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:44 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-Wyc9dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:44 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)) 02:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:44 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-1cxtDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:44 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)) 02:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:44 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-b6qFZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:44 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)) 02:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:44 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-KaWbV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:44 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)) 02:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:44 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-m5hmj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-cQk358-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-sV2bwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-ywkmng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-FqxOlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-UYC61H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-PXbQpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-WI9Ir_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-_W_wVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:45 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)) 02:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:45 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-N4ETex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:46 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)) 02:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:46 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-W8ViEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:46 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)) 02:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:46 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-RtQdNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:46 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)) 02:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:46 INFO - Running setup.py (path:/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/pip-DJMUeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:46 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)) 02:15:46 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)) 02:15:46 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)) 02:15:46 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)) 02:15:46 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)) 02:15:46 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)) 02:15:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:15:46 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 02:15:46 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 02:15:46 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 02:15:46 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 02:15:46 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 02:15:46 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 02:15:50 INFO - Downloading blessings-1.6.tar.gz 02:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:15:50 INFO - Installing collected packages: blessings 02:15:50 INFO - Running setup.py install for blessings 02:15:50 INFO - Successfully installed blessings 02:15:50 INFO - Cleaning up... 02:15:50 INFO - Return code: 0 02:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:50 INFO - Reading from file tmpfile_stdout 02:15:50 INFO - Current package versions: 02:15:50 INFO - blessings == 1.6 02:15:50 INFO - blobuploader == 1.2.4 02:15:50 INFO - docopt == 0.6.1 02:15:50 INFO - manifestparser == 1.1 02:15:50 INFO - mozInstall == 1.12 02:15:50 INFO - mozcrash == 0.17 02:15:50 INFO - mozdebug == 0.1 02:15:50 INFO - mozdevice == 0.48 02:15:50 INFO - mozfile == 1.2 02:15:50 INFO - mozhttpd == 0.7 02:15:50 INFO - mozinfo == 0.9 02:15:50 INFO - mozleak == 0.1 02:15:50 INFO - mozlog == 3.1 02:15:50 INFO - moznetwork == 0.27 02:15:50 INFO - mozprocess == 0.22 02:15:50 INFO - mozprofile == 0.28 02:15:50 INFO - mozrunner == 6.11 02:15:50 INFO - mozscreenshot == 0.1 02:15:50 INFO - mozsystemmonitor == 0.0 02:15:50 INFO - moztest == 0.7 02:15:50 INFO - mozversion == 1.4 02:15:50 INFO - psutil == 3.1.1 02:15:50 INFO - requests == 1.2.3 02:15:50 INFO - wsgiref == 0.1.2 02:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:50 INFO - 'HOME': '/Users/cltbld', 02:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:50 INFO - 'LOGNAME': 'cltbld', 02:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:50 INFO - 'MOZ_NO_REMOTE': '1', 02:15:50 INFO - 'NO_EM_RESTART': '1', 02:15:50 INFO - 'PAGER': '/bin/cat', 02:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:50 INFO - 'PWD': '/builds/slave/test', 02:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:50 INFO - 'SHELL': '/bin/bash', 02:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:50 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:50 INFO - 'USER': 'cltbld', 02:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:50 INFO - 'XPC_FLAGS': '0x0', 02:15:50 INFO - 'XPC_SERVICE_NAME': '0', 02:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:15:51 INFO - Cleaning up... 02:15:51 INFO - Return code: 0 02:15:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:51 INFO - 'HOME': '/Users/cltbld', 02:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:51 INFO - 'LOGNAME': 'cltbld', 02:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:51 INFO - 'MOZ_NO_REMOTE': '1', 02:15:51 INFO - 'NO_EM_RESTART': '1', 02:15:51 INFO - 'PAGER': '/bin/cat', 02:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:51 INFO - 'PWD': '/builds/slave/test', 02:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:51 INFO - 'SHELL': '/bin/bash', 02:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:51 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:51 INFO - 'USER': 'cltbld', 02:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:51 INFO - 'XPC_FLAGS': '0x0', 02:15:51 INFO - 'XPC_SERVICE_NAME': '0', 02:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:51 INFO - Downloading/unpacking jsonschema 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15: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 02:15:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:15:55 INFO - Downloading/unpacking functools32 (from jsonschema) 02:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:15:56 INFO - warning: no files found matching '*.txt' 02:15:56 INFO - no previously-included directories found matching 'build' 02:15:56 INFO - no previously-included directories found matching 'dist' 02:15:56 INFO - no previously-included directories found matching '.git*' 02:15:56 INFO - Installing collected packages: jsonschema, functools32 02:15:56 INFO - Running setup.py install for functools32 02:15:56 INFO - warning: no files found matching '*.txt' 02:15:56 INFO - no previously-included directories found matching 'build' 02:15:56 INFO - no previously-included directories found matching 'dist' 02:15:56 INFO - no previously-included directories found matching '.git*' 02:15:56 INFO - Successfully installed jsonschema functools32 02:15:56 INFO - Cleaning up... 02:15:56 INFO - Return code: 0 02:15:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:15: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')]} 02:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104597a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a7420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b21cabde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, '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.JtL1C8wRqy/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.c66dC3MDFR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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 02:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:56 INFO - 'HOME': '/Users/cltbld', 02:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:56 INFO - 'LOGNAME': 'cltbld', 02:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:56 INFO - 'MOZ_NO_REMOTE': '1', 02:15:56 INFO - 'NO_EM_RESTART': '1', 02:15:56 INFO - 'PAGER': '/bin/cat', 02:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:56 INFO - 'PWD': '/builds/slave/test', 02:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:56 INFO - 'SHELL': '/bin/bash', 02:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:15:56 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:56 INFO - 'USER': 'cltbld', 02:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:56 INFO - 'XPC_FLAGS': '0x0', 02:15:56 INFO - 'XPC_SERVICE_NAME': '0', 02:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:56 INFO - Downloading/unpacking flake8 02:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:15:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:16:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:00 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 02:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:16:01 INFO - no previously-included directories found matching 'docs/_build' 02:16:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:16:01 INFO - Running setup.py install for pep8 02:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:16:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:16:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:16:01 INFO - no previously-included directories found matching 'docs/_build' 02:16:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:16:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:16:01 INFO - Cleaning up... 02:16:01 INFO - Return code: 0 02:16:01 INFO - Running post-action listener: _resource_record_post_action 02:16:01 INFO - Running post-action listener: _start_resource_monitoring 02:16:01 INFO - Starting resource monitoring. 02:16:01 INFO - ##### 02:16:01 INFO - ##### Running install step. 02:16:01 INFO - ##### 02:16:01 INFO - Running pre-action listener: _resource_record_pre_action 02:16:01 INFO - Running main action method: install 02:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:01 INFO - Reading from file tmpfile_stdout 02:16:01 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:16:01 INFO - Reading from file tmpfile_stdout 02:16:01 INFO - Output received: 02:16:01 INFO - Usage: mozinstall [options] installer 02:16:01 INFO - Options: 02:16:01 INFO - -h, --help show this help message and exit 02:16:01 INFO - -d DEST, --destination=DEST 02:16:01 INFO - Directory to install application into. [default: 02:16:01 INFO - "/builds/slave/test"] 02:16:01 INFO - --app=APP Application being installed. [default: firefox] 02:16:01 INFO - mkdir: /builds/slave/test/build/application 02:16:01 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'] 02:16:01 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 02:16:35 INFO - Reading from file tmpfile_stdout 02:16:35 INFO - Output received: 02:16:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:16:35 INFO - Running post-action listener: _resource_record_post_action 02:16:35 INFO - ##### 02:16:35 INFO - ##### Running run-tests step. 02:16:35 INFO - ##### 02:16:35 INFO - Running pre-action listener: _resource_record_pre_action 02:16:35 INFO - Running main action method: run_tests 02:16:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:16:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:16:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:16:35 INFO - 2016-03-30 02:16:35.840 screenresolution[1969:28102] starting screenresolution argv=screenresolution get 02:16:35 INFO - 2016-03-30 02:16:35.843 screenresolution[1969:28102] Display 0: 1600x1200x32@60 02:16:35 INFO - 2016-03-30 02:16:35.849 screenresolution[1970:28104] starting screenresolution argv=screenresolution list 02:16:35 INFO - Available Modes on Display 0 02:16:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:16:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:16:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:16:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:16:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:16:36 INFO - Intel Iris: 02:16:36 INFO - Chipset Model: Intel Iris 02:16:36 INFO - Type: GPU 02:16:36 INFO - Bus: Built-In 02:16:36 INFO - VRAM (Dynamic, Max): 1536 MB 02:16:36 INFO - Vendor: Intel (0x8086) 02:16:36 INFO - Device ID: 0x0a2e 02:16:36 INFO - Revision ID: 0x0009 02:16:36 INFO - Displays: 02:16:36 INFO - Display: 02:16:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:16:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:16:36 INFO - Display Serial Number: 1600x1200 60 02:16:36 INFO - Main Display: Yes 02:16:36 INFO - Mirror: Off 02:16:36 INFO - Online: Yes 02:16:36 INFO - Rotation: Supported 02:16:36 INFO - Return code: 0 02:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:16:36 INFO - Python 2.7.3 02:16:36 INFO - Return code: 0 02:16:36 INFO - grabbing minidump binary from tooltool 02:16: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')]} 02:16:36 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 0x104436e00>, '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 0x10425fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104431b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:16:36 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 02:16:36 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 02:16:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:16:36 INFO - Return code: 0 02:16:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:16:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:16:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:16:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:16:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:16:37 INFO - Return code: 0 02:16:37 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/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 02:16:37 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/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0089 --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 02:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JtL1C8wRqy/Render', 02:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:37 INFO - 'HOME': '/Users/cltbld', 02:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:37 INFO - 'LOGNAME': 'cltbld', 02:16:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:16:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:37 INFO - 'MOZ_NO_REMOTE': '1', 02:16:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:16:37 INFO - 'NO_EM_RESTART': '1', 02:16:37 INFO - 'PAGER': '/bin/cat', 02:16:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:37 INFO - 'PWD': '/builds/slave/test', 02:16:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:37 INFO - 'SHELL': '/bin/bash', 02:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c66dC3MDFR/Listeners', 02:16:37 INFO - 'TMPDIR': '/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/', 02:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:37 INFO - 'USER': 'cltbld', 02:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:37 INFO - 'XPC_FLAGS': '0x0', 02:16:37 INFO - 'XPC_SERVICE_NAME': '0', 02:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:37 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/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0089', '--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 02:16:37 INFO - mozversion application_buildid: 20160330002037 02:16:37 INFO - mozversion application_changeset: 85d231a303cfe702634035ae2470e343842e9e21 02:16:37 INFO - mozversion application_display_name: Nightly 02:16:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:16:37 INFO - mozversion application_name: Firefox 02:16:37 INFO - mozversion application_remotingname: firefox 02:16:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:16:37 INFO - mozversion application_vendor: Mozilla 02:16:37 INFO - mozversion application_version: 48.0a1 02:16:37 INFO - mozversion platform_buildid: 20160330002037 02:16:37 INFO - mozversion platform_changeset: 85d231a303cfe702634035ae2470e343842e9e21 02:16:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:16:37 INFO - mozversion platform_version: 48.0a1 02:16:37 INFO - using testdate: 1459329397 02:16:37 INFO - actual date: 1459329397 02:16:37 INFO - starting webserver on 'localhost:50757' 02:16:37 INFO - SUITE-START | Running 2 tests 02:16:37 INFO - TEST-START | dromaeo_css 02:16:37 INFO - operating with platform_type : mac_ 02:16:37 INFO - Initialising browser for dromaeo_css test... 02:16:37 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpVS4Zq1/profile http://localhost:50757/getInfo.html) 02:16:39 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 02:16:39 INFO - PROCESS | 1988 | colorDepth:24 02:16:39 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 02:16:39 INFO - PROCESS | 1988 | __metrics 02:16:39 INFO - PROCESS | 1988 | 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" 02:16:39 ERROR - PROCESS | 1988 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:16:40 INFO - TEST-INFO | 1988: exit 0 02:16:40 INFO - Browser initialized. 02:16:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:40 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpVS4Zq1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:52 INFO - PROCESS | 1991 | RSS: Main: 244350976 02:16:52 INFO - PROCESS | 1991 | 02:17:43 INFO - PROCESS | 1991 | 1459329463880 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] 02:19:54 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50757/tests/dromaeo/cssquery-ext.html) 02:19:55 INFO - PROCESS | 1991 | RSS: Main: 340828160 02:19:55 INFO - PROCESS | 1991 | 02:22:57 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-ext.html (next: http://localhost:50757/tests/dromaeo/cssquery-jquery.html) 02:22:58 INFO - PROCESS | 1991 | RSS: Main: 378679296 02:22:58 INFO - PROCESS | 1991 | 02:26:00 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50757/tests/dromaeo/cssquery-mootools.html) 02:26:00 INFO - PROCESS | 1991 | RSS: Main: 374431744 02:26:00 INFO - PROCESS | 1991 | 02:29:03 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50757/tests/dromaeo/cssquery-prototype.html) 02:29:03 INFO - PROCESS | 1991 | RSS: Main: 331272192 02:29:03 INFO - PROCESS | 1991 | 02:32:06 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50757/tests/dromaeo/cssquery-yui.html) 02:32:07 INFO - PROCESS | 1991 | RSS: Main: 335724544 02:32:07 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-yui.html (next: http://localhost:50757/tests/dromaeo/cssquery-dojo.html) 02:35:10 INFO - PROCESS | 1991 | RSS: Main: 398438400 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | __start_tp_report 02:35:10 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 02:35:10 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 02:35:10 INFO - PROCESS | 1991 | |i|pagename|runs| 02:35:10 INFO - PROCESS | 1991 | |0;dojo.html;3403.1322012886712;3430.6912377886;3467.9769468006934;3468.5952189363315;3491.4413693808997;5530.5299049580835;5597.132444471104;5636.661800291985;5651.519620832229;5663.037283661783;5608.270924779773;5665.943340566593;5668.178114173453;5684.744186511606;5684.971575142129;5113.284140220372;5126.897462050757;5136.460671629481;5152.793888244484;5199.194124910626;5213.374395072597;5221.216817477371;5225.634205605609;5225.817096401626;5230.058589453897;5132.358455193101;5162.303089082963;5172.19830926207;5192.974035129819;5200.791968321281;4450.688451808374;5183.429822719517;5239.449857764956;5239.659422137549;5296.947030529684;5045.596352291808;5059.3169922060415;5079.8222062228015;5160.406553246387;5162.819301324474;5583.972080139614;5605.411431799643;5618.606697531174;5639.210510528488;5711.657300561938;6206.224221972254;6206.317305096436;6207.099970504251;6212.099245609361;6240.594361366542;6076.684103182968;6121;6228.5017198624;6299.811005669837;6312.147860038928;5793.8841223175305;5806.477417032445;5812.505936995318;5813.82558523245;5848.88302233953;5914.940850591525;5955.719520303156;6223.813285601439;6243.719032643542;6252.812415627538;5045;5900.64596124234;6015.428534289235;6098.311206366174;6109.816705498753;6129.478994285536;6189.412005859436;6191.442770150708;6201.627902325875;6205.131281620576;6099.359567245464;6170;6192.59748116371;6196.535259855529;6216.564840461215;5960.791372302036;6075.179850720185;6101.792513241505;6209.844753881189;6234.844128896814;4863.683860549053;4877.414710234723;4880.707157570557;4908.9754551227015;4948.628852836052;4399.802008909607;4403.493598236179;4407.735535867858;4425.601695847389;4460.799264033127;5608.635438696471;5652.830415087554;5706.828795136153;5755.021646320136;5794.101914203306;6204.472619827366;6225.066240063936;6234.345393733593;6234.688265586793;6236.75052997875;5677.51741102011;5720.971395143081;5730.598858079978;5739;5765.827025189251;5256.211568264791;5288.444713305124;5351.625386222927;5352.197170424468;5392.811251606254;6265.780697675559;6286.18279623646;6290.433860952537;6293.307736148929;6299.338569450142;6098.67428752872;6154.353792851686;6235.376462353728;6235.906461403173;6257.124002639725;6172.5679202457195;6234.937650623617;6259.812205633838;6276.497880169484;6290.905636415366;6117.755289788359;6168.25980882297;6170.9074363885475;6191.288001879661;6202.937970620236;6043.848903777441;6115.575014303803;6260.718267677874;6280.685965701605;6300.275468321019;6052.969735151296;6111.98679349419;6124.106319906264;6137.376985335611;6141.232345956755;6046.486048685735;6047.365026672312;6079.513638908965;6080.209572755691;6097.908531372122;5808.30300363959;5859.150423188699;5877.735501902339;5951.256092988377;5976.372480889618;5916.585838991229;6070.757169713162;6091.177691011834;6104.4505994460715;6108.389161083856;5849.444302791228;5900.64596124234;5912.290525137011;5922.111683247547;5926.555508336978 02:35:10 INFO - PROCESS | 1991 | |1;ext.html;462.09890713109445;582.3215953414273;582.9562782791289;642.2934771751075;647.8088963755691;24346.63480047801;38078.66724664637;38425.23149537011;38431;38440.423393649115;39625.20749585007;40308.79845600775;40422.19155616886;40426;40465.19069618613;9486.288528360366;9718.951405242964;9729.027097290285;9741.366811157288;9758.072983066597;9547.093026162504;9688.467134307646;9702.854457183113;9717.222622190244;9722.222222222204;9664.226861851035;9853.162481189107;9887.258455615822;9888.258380621446;9894.85157722631;9755.804883902318;9843.90156098437;9848.655297064568;9863.457509836991;9868.013198680146;9608.75978100553;9732.659356922473;9746.074122958307;9753.21974242059;9761.65834195807;40495.59504404948;40791.388129178085;40806.795966020276;40850;41063.17873642511;3225.5322978168033;3243.2540515681526;3255.0723043932603;3267.9346413071844;3485.0416135562923;27682.861585691942;27808.58287125695;28001.159965201077;28277.57583636247;28416.431671366663;2544.300317412726;2699.25770413136;2768.806183567151;2774.861256937145;2824.4068745563454;473914;474576;476805;480877;481647.59176203894;44291;44754.55245447504;44947.101057979315;67452.3254767446;68100.6594967022;43795.78102109469;43863.78068109703;44106.338404923954;44150.89622759393;44238.33642495365;15312.617184570476;15502.224888755518;15507.224638768017;15522.689546209012;15529.689406211812;10354.53404596795;12440;12509.43707533145;12515.99872010237;12521.499140034479;14519;14524.346404411826;14565.198914059829;14573.344199511048;14615.196164211071;6242.781502647385;6364.1408409865;6412.358764123644;6414.518911081687;6416.13382193398;955.6559638530124;956.7177682583655;962.3311798300114;965.4207475514635;1145.4673576786834;23859.880700596732;28211.858940705166;29558;29565.85217073901;29699.10902672923;1053.8103141434462;1078.5524007536785;1151.7178291318512;1163.837062811207;1267.7718010758151;14631.561053168421;14666.779998300033;14682.119072855663;15039.323230454656;15144.394224230908;525655;532432;532533;533573;533616;57465.13802292969;57959.999999999156;58139.70930145322;58155.41844581585;58176.70911645499;1142.4344949250174;1367.8495365509984;1458.2562892924473;1474.837767845536;1518.422999260274;24995.87502062478;26559.60160597554;28001.43997120087;28449.167920576645;28509.857450712614;43256.56743432651;43581.56418435902;43702.344464832415;43833.56166438295;43865.90335241645;368821;369728;371999;373297;373430;32811.70318077712;42067.7896610515;43561.78219109011;44047.77976110099;44101.77949110234;41392.586074138875;42536.93657658583;44564.77717611521;46623;47365.526344736114;34074.31851362909;35174.29651407008;35451.29097417986;35932.28135437329;35968.460473092404;34121;34478.31043379169;34625;35337.293254135286;35352.823235883654;35181.120471988404;35447;35477.645223547435;35482.29035419329;36670.266594668494;28309.716902830707;30356.089317320515;30468.695313046584;30672.079837604906;30823.691763082978;19156.46528225196;23383.88308058449;23397.363916296326;23399.76600233976;23822.404439889142 02:35:10 INFO - PROCESS | 1991 | |2;jquery.html;356.1274876552446;358.32276996476656;360.27584555044353;370.3370965970912;371.5096073183397;19414.417567472963;19980.50048748782;20550.38348849535;21049.789502104974;21130.57738845222;19935.202591896308;20295.898520507413;21061.894690526566;21196.894015529902;21197.788022119774;5541.168824676301;5679.233303504016;5720.713964301789;5745.597808153431;5746.224259724946;4048.7773172475504;4336.783160841961;6094.421030002142;6354.046892966046;6398.584092034026;6216.1918950536365;6308.589941653778;6309.116723658692;6323.873522529547;6329.58857674252;5045.596352291826;5067.315912351823;6269.96865015672;6270.122182894398;6298.212723409574;3580.104973756561;5092.643514953955;5486.1222204447495;5495.972520137374;5496.148097044925;24504.387390315205;25102.121425750192;25869.61195582049;25916.8704156478;25920.96316147352;2008.3974807557674;2212.9225477108225;2256.3231030690727;2262.908455974058;2267.115824828318;12361.258324500559;14444;14514.419423223058;15018.849811501854;15538.844611553854;1728.7752592163065;1775.343123044469;1782.322717367392;1787.2136260045668;1793.5695433095964;83040;101588;101653;103138;105515.94484055138;10203.081722644998;10263.486825658687;10592.152627789912;10614.628488002883;10744.710634723882;13126.015548833875;13132.949364050854;13174.670633234246;13185.868141318655;13205.207687538586;8386.79033024167;8538.274246688978;8600.354973377021;8680.30557555394;8711.303095752324;7176.677049532784;8727.956360218159;8786.428882122642;8830.337724670675;8883.866741998876;6124.418180272867;6208.503319734501;6222.906656400158;6237.688115594202;6325.557210995278;1449.0870751426535;1662.5843539115222;1744.5551384396897;1745.1361576019951;1826.7807863056253;930.8417569013284;953.9618415263312;968.3415277611292;1011.4234886114843;1079.7030816525519;17149.742753858704;19166.137523811463;19989;20080.09639566223;20084.288621035972;855.5551113420986;921.6267411698273;939.7782882253043;956.7368973532334;972.9221662267001;10739.731506712238;11134;11145.387003714874;11175.83236251457;11411.315321080761;333243;443444;444248;625547;626165;107849;108295;108301;110810.44594776974;111974;1001.5092604623827;1018.4856647393019;1042.166266986408;1042.338115296792;1055.2982266792496;17762.46712598624;18002.36991705284;18271.36050238235;18393.356232531798;18669.71995420097;42445.57554424416;43980.58106804157;47654.761726191144;48047.79880503016;48216.79458013578;56816;72261;72585;72746.63626681833;74067.8889816664;7555.09338879338;7592.734254301073;7639.503432276884;7760.922390776246;7984.20157984197;10117.747056323651;12159;12162.817557736818;12280.140390172603;12524;10119.494025298558;10632.574697012033;10666.746522526913;10869.29349592274;11029.944850276019;10659.680209593724;10728.73178170552;10802.67591972242;11008.504617292401;11116.833247501456;9111.772205694646;10947.671569852917;10963.616273430393;11317.773644526898;11425.657230283105;7493.325600695964;7722.575258360619;7754.534727916343;7841.137474877873;8119.959400202961;8266.462679925786;10077.949610251902;10802.405867677038;11389.259698119597;11417.60038398652 02:35:10 INFO - PROCESS | 1991 | |3;mootools.html;1446.7902154187636;1584.6117701163214;1619.481765834933;1908.9140988655508;2041.520242742956;8061.87907181392;8281.710140145096;8630.352723545744;8899.288056955444;8968.10318968103;8722.25860801831;8788.91211087889;8887.644494220223;8896.421732587378;8906.821863562725;2200.90095945682;2411;2456.427886152859;2486.080150344375;2490.68866391701;2501.8123640727017;2507.272890861657;2507.7993760499207;2507.912223072193;2510.259473455326;2411.7347091819884;2426.9514609707794;2467.5064987002584;2486.639437281593;2487.776100150986;2449.640449550499;2469.4196863737006;2483.1681386735463;2491.231225829663;2493.0775613023116;2421.3825474504065;2473.4929339485543;2474.552386853693;2482.2305085423395;2482.640017197496;8909.242714369286;9010.098990101003;9011.774705632346;9012.0086790453;9015.323850711156;5492.286002819648;5607.943920560783;5638.577106717013;5649.463300986441;5673.063944449161;3636.236390358028;3713.4801127842125;3793.013816407726;3811.1805961718364;3814.828332725034;1039.4335087377397;1057.6509751781894;1061.925665203436;1067.626330784227;1077.6659235636978;12172.81740773889;12173.452194651174;12180.20828646144;12193.634190974373;12251.142420030601;4843.055604157155;4875.975620121877;4974.129527332702;4992.775325110379;5014.874628134326;10303.227257955683;10320.638777642747;10325.896741032644;10327.431991240554;10329.535170917326;5586.273784408001;5603.019471592455;5612.5229355504425;5617.073182924772;5628.634138780966;4199.559046300155;4444.266695995125;4597;4763.476017638057;4984.626153038536;3846.3268927938057;3899.512560929884;3914.5889681583594;3946.210757848442;3955.110100227426;1282.4421376701164;1302.5896842494583;1305.8041293806004;1314.2574445438297;1318.7494376068516;1063.984040239397;1089.841972913939;1106.43571778392;1417.4684493315008;1418.432626949208;8249.175082491704;8251;8317.293030092389;8358.540280284642;8358.665653373797;454.8862784303924;520.971346575942;535.1357557544537;537.704262655538;538.64449463354;6192.721327540272;6204.162438070893;6260.686965651699;6271.498280137578;6284.12022316876;10502.422366769748;10868;10934.890651093547;11053.447327633587;11068.114550835913;10687.519061642244;10746.355218686904;10804.891951080388;10858.131349492021;10931.125509959184;8365.24712775841;8396.286315663116;8412.8317433651;8436.704715334934;8469.153084691605;7769.72805951789;7972.043354797462;7991.3606911448105;8005.879911801444;8078.87881681787;9438.95280523593;9638.662646807328;9699.806003879741;9716.902830971883;9734.659286924923;9048.638054477748;9545.61817527319;9865.309428339948;10003.749906252402;10278.383297002203;6783.966080169567;6796.72813087471;7023.964880175567;7607.961960190164;7668.5782281975025;7761.9611901940125;7832.84334313322;8103.189681031849;8116.837663246584;8123.7156699515235;7188.676509556978;7291.52605080668;7309.671064801991;7428.997085393619;7457.6271186441545;7174.031505746658;7185.209626940928;7222.819429514304;7332.743353982585;7357.153927298215;7400.296971787671;7652.387808975157;7707.88438173439;7720.729774457867;7723.652435640522;6962.268961758942;6975.930240697731;7035.718571257093;7036.788896333118;7040.929590704232;7050.506464547432;7089.149302083783;7105.147382314155;7126.964365178141;7141.464390170862 02:35:10 INFO - PROCESS | 1991 | |4;prototype.html;294.3627047442287;328.2155648001277;330.39207857542124;335;337.2428897125953;5092.847214583564;6255.530835187362;6559.048937904001;6580.374864387887;6621.966890165554;6348.206474190726;6456.257530384008;6508.153939987807;6521.413072823445;6544.509161812859;3872.4772155759033;4586.082783443308;4699;4717.669763116583;4868.123737727207;3772.830222639988;4756;4801.663883528155;4805.9426926076385;4814.566688997989;4728.881777955561;4738.47876733559;4746.715197088186;4758.643101767364;4769.022350418173;4546.909061818778;4610.585047345755;4735.313379559944;4766.142094423002;4778.474367819537;4064.5935406459116;4081.306177949726;4082.8979275518054;4088.8568900088353;4093.2018256440006;6240.313565507836;6241.282252540925;6249.9062514062325;6270.216222972129;6283.3088360280335;4590.724556526619;4667.4632417272105;5652.463016013472;5684.573656975702;5695.829125126253;6910.378065974087;6927.861442771166;6944.895826562605;6952.409045231161;6953.235144134142;4308.9353659695125;4494.865154045384;4496.100779844044;4638.512956139591;4645.465771436295;5903.881922361572;7210;7250.927490725078;7286.854262914765;7307.817304567375;4578.725276483422;4578.793954272066;4587.6788624795945;4589.472210695746;4594.218982772936;4641.419822522184;4649.976750116228;4655.068986202773;4662.487126416091;4663.790129444184;5523.337199536081;5526.834194974077;5527.806526771544;5529.557635389159;5538.390777014525;6727.192736871509;6941.132358455193;6963.547369420971;6980.371766540934;6999.195092564319;1588.9443869464512;1605.6387312854747;1612.3469994652185;1616.6200942778437;1617.8624816890697;1012.8480727890728;1014.8731408573929;1031.9071283584362;1034.8654674892216;1038.9532471038822;6233.161217440866;6365.936340636535;6447.3552644735155;6448.193975753031;6465.094886715863;6080.14877917092;6129.877402451926;7280.126384833854;7370.484066115428;7385;6617.636030018395;6647.235567909753;6648.83377915556;6660.766873159513;6665.766698165541;3819.0643292393543;3875.2636998970106;3875.496185495924;3883.7281390302974;3885.8834234972996;7293.817654558572;7590.240975902476;7603.695852165962;7633.122190948001;7633.847323053508;7424.740134095281;7467.066616672916;7476.70093196266;7489.812754681067;7491.288327608869;7554.584497852671;7571.545707257582;7587.013688220496;7590.051243594551;7590.544567325978;6598.670066496752;7262.455315851226;7267.527610705287;7281.381082608038;7316.1952185258515;6322.178116844781;7063.223045465097;7141;7142.178649455379;7173.031640728644;6172.259328880563;6522.28254891952;6968.024476573182;7516.8496630066;7605.087389513294;4737.076270127292;4806.591439727662;4822.397200349957;4824.589909857561;4831.589314908272;7213.567185968858;7217.386522145676;7231.819204519929;7245.8768890822;7254.419646428379;6759.723025961461;6900.378965893094;6966.5471744336455;7033.402160816388;7037.648117594203;6902.24075351721;6929.272426395358;6974.58152510851;6976.407005404394;6986.406155476841;5618.7190640467;5740.397258287987;6764;6841.144856892888;6884.724611015704;6987.567548652616;6994.510384273052;6999.790006299819;7005.929940700732;7019.613921234381;5831.192330377597;6393.881070812497;6527.412532872065;6624.238212605612;6771.424428923597 02:35:10 INFO - PROCESS | 1991 | |5;yui.html;695.2005194026868;746.264929044891;763.8281386687993;777.3237283563299;783.8118851475648;14950.476733314335;15191.544253672393;15195;15196.848031519681;15225.771613425808;13828.377723002464;13864.445422183126;13915.234662093606;13927.512537061204;14015.15909045458;715.8997740316333;732.0848938826467;898.294838551737;898.9190972812446;915.9924083508121;910.9726708198765;917.6788124156525;920.9677661281856;921.0375157959948;921.2031592672324;964.9807003859919;965.290511474066;967.1585720423242;967.3470407474962;968.1915600473613;757.7120694136192;773.6479901644739;956.6747305915987;958.108958668438;961.3943215774052;567.4779203133086;570.8116321613858;711.434409644334;726.0815068937798;726.9491135620509;14849.851501484954;14923;14941.925290373587;14953;14976.400943962228;12241.938790305992;12344.75310493785;12475.50097996079;12564.308963007032;12714;9835.704928852147;9878.236668157617;9900.801983960353;9972.750681232954;10247.538860751283;3457.723382129449;3505.8948231553095;3536.1513236822975;3554.733394995386;3599.208174201671;78686;81993.18006819914;84093.99999999939;85110.14889851084;85244;9402.811943761086;9412.623495060257;9485.098915603006;9735.853962190573;9812.509374531388;21621.783782161976;21713.56572868534;21742.13031478723;21744.78255217459;21766.238181663564;7188.892166617505;7344.081989751281;7459.888101678479;7523;7623.771286861403;3451.775634583744;3833.15670552478;4048.8380464781667;4116.567760385176;4119.505659320901;3560.7863528187872;3600.6399360064306;3602.819859007039;3605.7115430765475;3622.9094272643397;644.22049320322;645.0197892470165;653.2683394597985;656.6454114777966;667.3693359775064;547.1300631995147;588.106078760282;594.180031556458;603.3544107804607;612.6599737145838;7985.121636619967;8210.58947052657;8262.876056859152;8264.8347033059;8336.333093352518;515.6364762842187;564.350996354196;582.6620560075146;592.6503363015842;616.6392660293689;3315.8063097284958;3358.899233023013;3561.554805649294;3783.9621603784162;3840.385538313912;87729.56135219283;87972.0825125729;89477.55261223653;89727;96759.51620241995;71610.64194679097;71972.64013679897;72380;72512.2748772516;72766.18084547823;68633;69049;69372.653136735;69618.3038169622;71492.2850771496;7088.574685518885;8188.181181881764;8321.583920803814;8386.958065209636;8394.916050839414;46219;47582.52417475781;47996.760016199696;48181.072757090726;50303.245451317525;63810;63912;66066.33933660602;70417.64791176216;71308;10979.121670266519;11015.504302306255;11328.150388721044;11433.885661143282;11606.071514279007;11974.401279936143;12064.457099430721;12422.130450868352;12722.554710585086;12939.094263401472;11417;11560.421978900853;11683.88316116862;11775;11807.881921180679;11505.712357191138;11506.76986460283;11565.942170289094;11670.94164529172;11938.403079846146;11234.810305005652;11458.140639452242;11709.121815863675;11753.412329383325;11771.764564708828;9567.186789123003;9653.662121825982;9771.75570610712;10004.249681273788;10231.181505479395;7578.696852125853;9084.72813806081;9163.587638556148;9634.518274086407;9646.711438754943 02:35:10 INFO - PROCESS | 1991 | __end_tp_report 02:35:10 INFO - PROCESS | 1991 | __start_cc_report 02:35:10 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,954 02:35:10 INFO - PROCESS | 1991 | __end_cc_report 02:35:10 INFO - PROCESS | 1991 | __startTimestamp1459330510270__endTimestamp 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | ------- Summary: start ------- 02:35:10 INFO - PROCESS | 1991 | Number of tests: 6 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#0] dojo.html Cycles:165 Average:5702.78 Median:5912.29 stddev:627.43 (10.6%) stddev-sans-first:602.86 02:35:10 INFO - PROCESS | 1991 | Values: 3403.1 3430.7 3468.0 3468.6 3491.4 5530.5 5597.1 5636.7 5651.5 5663.0 5608.3 5665.9 5668.2 5684.7 5685.0 5113.3 5126.9 5136.5 5152.8 5199.2 5213.4 5221.2 5225.6 5225.8 5230.1 5132.4 5162.3 5172.2 5193.0 5200.8 4450.7 5183.4 5239.4 5239.7 5296.9 5045.6 5059.3 5079.8 5160.4 5162.8 5584.0 5605.4 5618.6 5639.2 5711.7 6206.2 6206.3 6207.1 6212.1 6240.6 6076.7 6121.0 6228.5 6299.8 6312.1 5793.9 5806.5 5812.5 5813.8 5848.9 5914.9 5955.7 6223.8 6243.7 6252.8 5045.0 5900.6 6015.4 6098.3 6109.8 6129.5 6189.4 6191.4 6201.6 6205.1 6099.4 6170.0 6192.6 6196.5 6216.6 5960.8 6075.2 6101.8 6209.8 6234.8 4863.7 4877.4 4880.7 4909.0 4948.6 4399.8 4403.5 4407.7 4425.6 4460.8 5608.6 5652.8 5706.8 5755.0 5794.1 6204.5 6225.1 6234.3 6234.7 6236.8 5677.5 5721.0 5730.6 5739.0 5765.8 5256.2 5288.4 5351.6 5352.2 5392.8 6265.8 6286.2 6290.4 6293.3 6299.3 6098.7 6154.4 6235.4 6235.9 6257.1 6172.6 6234.9 6259.8 6276.5 6290.9 6117.8 6168.3 6170.9 6191.3 6202.9 6043.8 6115.6 6260.7 6280.7 6300.3 6053.0 6112.0 6124.1 6137.4 6141.2 6046.5 6047.4 6079.5 6080.2 6097.9 5808.3 5859.2 5877.7 5951.3 5976.4 5916.6 6070.8 6091.2 6104.5 6108.4 5849.4 5900.6 5912.3 5922.1 5926.6 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#1] ext.html Cycles:180 Average:59632.94 Median:38435.71 stddev:123720.34 (321.9%) stddev-sans-first:123987.65 02:35:10 INFO - PROCESS | 1991 | Values: 462.1 582.3 583.0 642.3 647.8 24346.6 38078.7 38425.2 38431.0 38440.4 39625.2 40308.8 40422.2 40426.0 40465.2 9486.3 9719.0 9729.0 9741.4 9758.1 9547.1 9688.5 9702.9 9717.2 9722.2 9664.2 9853.2 9887.3 9888.3 9894.9 9755.8 9843.9 9848.7 9863.5 9868.0 9608.8 9732.7 9746.1 9753.2 9761.7 40495.6 40791.4 40806.8 40850.0 41063.2 3225.5 3243.3 3255.1 3267.9 3485.0 27682.9 27808.6 28001.2 28277.6 28416.4 2544.3 2699.3 2768.8 2774.9 2824.4 473914.0 474576.0 476805.0 480877.0 481647.6 44291.0 44754.6 44947.1 67452.3 68100.7 43795.8 43863.8 44106.3 44150.9 44238.3 15312.6 15502.2 15507.2 15522.7 15529.7 10354.5 12440.0 12509.4 12516.0 12521.5 14519.0 14524.3 14565.2 14573.3 14615.2 6242.8 6364.1 6412.4 6414.5 6416.1 955.7 956.7 962.3 965.4 1145.5 23859.9 28211.9 29558.0 29565.9 29699.1 1053.8 1078.6 1151.7 1163.8 1267.8 14631.6 14666.8 14682.1 15039.3 15144.4 525655.0 532432.0 532533.0 533573.0 533616.0 57465.1 57960.0 58139.7 58155.4 58176.7 1142.4 1367.8 1458.3 1474.8 1518.4 24995.9 26559.6 28001.4 28449.2 28509.9 43256.6 43581.6 43702.3 43833.6 43865.9 368821.0 369728.0 371999.0 373297.0 373430.0 32811.7 42067.8 43561.8 44047.8 44101.8 41392.6 42536.9 44564.8 46623.0 47365.5 34074.3 35174.3 35451.3 35932.3 35968.5 34121.0 34478.3 34625.0 35337.3 35352.8 35181.1 35447.0 35477.6 35482.3 36670.3 28309.7 30356.1 30468.7 30672.1 30823.7 19156.5 23383.9 23397.4 23399.8 23822.4 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#2] jquery.html Cycles:180 Average:30626.03 Median:2234.62 stddev:84676.74 (3789.3%) stddev-sans-first:84883.78 02:35:10 INFO - PROCESS | 1991 | Values: 356.1 358.3 360.3 370.3 371.5 19414.4 19980.5 20550.4 21049.8 21130.6 19935.2 20295.9 21061.9 21196.9 21197.8 5541.2 5679.2 5720.7 5745.6 5746.2 4048.8 4336.8 6094.4 6354.0 6398.6 6216.2 6308.6 6309.1 6323.9 6329.6 5045.6 5067.3 6270.0 6270.1 6298.2 3580.1 5092.6 5486.1 5496.0 5496.1 24504.4 25102.1 25869.6 25916.9 25921.0 2008.4 2212.9 2256.3 2262.9 2267.1 12361.3 14444.0 14514.4 15018.8 15538.8 1728.8 1775.3 1782.3 1787.2 1793.6 83040.0 101588.0 101653.0 103138.0 105515.9 10203.1 10263.5 10592.2 10614.6 10744.7 13126.0 13132.9 13174.7 13185.9 13205.2 8386.8 8538.3 8600.4 8680.3 8711.3 7176.7 8728.0 8786.4 8830.3 8883.9 6124.4 6208.5 6222.9 6237.7 6325.6 1449.1 1662.6 1744.6 1745.1 1826.8 930.8 954.0 968.3 1011.4 1079.7 17149.7 19166.1 19989.0 20080.1 20084.3 855.6 921.6 939.8 956.7 972.9 10739.7 11134.0 11145.4 11175.8 11411.3 333243.0 443444.0 444248.0 625547.0 626165.0 107849.0 108295.0 108301.0 110810.4 111974.0 1001.5 1018.5 1042.2 1042.3 1055.3 17762.5 18002.4 18271.4 18393.4 18669.7 42445.6 43980.6 47654.8 48047.8 48216.8 56816.0 72261.0 72585.0 72746.6 74067.9 7555.1 7592.7 7639.5 7760.9 7984.2 10117.7 12159.0 12162.8 12280.1 12524.0 10119.5 10632.6 10666.7 10869.3 11029.9 10659.7 10728.7 10802.7 11008.5 11116.8 9111.8 10947.7 10963.6 11317.8 11425.7 7493.3 7722.6 7754.5 7841.1 8120.0 8266.5 10077.9 10802.4 11389.3 11417.6 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#3] mootools.html Cycles:180 Average:6083.41 Median:538.17 stddev:3245.91 (603.1%) stddev-sans-first:3236.31 02:35:10 INFO - PROCESS | 1991 | Values: 1446.8 1584.6 1619.5 1908.9 2041.5 8061.9 8281.7 8630.4 8899.3 8968.1 8722.3 8788.9 8887.6 8896.4 8906.8 2200.9 2411.0 2456.4 2486.1 2490.7 2501.8 2507.3 2507.8 2507.9 2510.3 2411.7 2427.0 2467.5 2486.6 2487.8 2449.6 2469.4 2483.2 2491.2 2493.1 2421.4 2473.5 2474.6 2482.2 2482.6 8909.2 9010.1 9011.8 9012.0 9015.3 5492.3 5607.9 5638.6 5649.5 5673.1 3636.2 3713.5 3793.0 3811.2 3814.8 1039.4 1057.7 1061.9 1067.6 1077.7 12172.8 12173.5 12180.2 12193.6 12251.1 4843.1 4876.0 4974.1 4992.8 5014.9 10303.2 10320.6 10325.9 10327.4 10329.5 5586.3 5603.0 5612.5 5617.1 5628.6 4199.6 4444.3 4597.0 4763.5 4984.6 3846.3 3899.5 3914.6 3946.2 3955.1 1282.4 1302.6 1305.8 1314.3 1318.7 1064.0 1089.8 1106.4 1417.5 1418.4 8249.2 8251.0 8317.3 8358.5 8358.7 454.9 521.0 535.1 537.7 538.6 6192.7 6204.2 6260.7 6271.5 6284.1 10502.4 10868.0 10934.9 11053.4 11068.1 10687.5 10746.4 10804.9 10858.1 10931.1 8365.2 8396.3 8412.8 8436.7 8469.2 7769.7 7972.0 7991.4 8005.9 8078.9 9439.0 9638.7 9699.8 9716.9 9734.7 9048.6 9545.6 9865.3 10003.7 10278.4 6784.0 6796.7 7024.0 7608.0 7668.6 7762.0 7832.8 8103.2 8116.8 8123.7 7188.7 7291.5 7309.7 7429.0 7457.6 7174.0 7185.2 7222.8 7332.7 7357.2 7400.3 7652.4 7707.9 7720.7 7723.7 6962.3 6975.9 7035.7 7036.8 7040.9 7050.5 7089.1 7105.1 7127.0 7141.5 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#4] prototype.html Cycles:180 Average:5642.40 Median:6335.19 stddev:1809.36 (28.6%) stddev-sans-first:1769.35 02:35:10 INFO - PROCESS | 1991 | Values: 294.4 328.2 330.4 335.0 337.2 5092.8 6255.5 6559.0 6580.4 6622.0 6348.2 6456.3 6508.2 6521.4 6544.5 3872.5 4586.1 4699.0 4717.7 4868.1 3772.8 4756.0 4801.7 4805.9 4814.6 4728.9 4738.5 4746.7 4758.6 4769.0 4546.9 4610.6 4735.3 4766.1 4778.5 4064.6 4081.3 4082.9 4088.9 4093.2 6240.3 6241.3 6249.9 6270.2 6283.3 4590.7 4667.5 5652.5 5684.6 5695.8 6910.4 6927.9 6944.9 6952.4 6953.2 4308.9 4494.9 4496.1 4638.5 4645.5 5903.9 7210.0 7250.9 7286.9 7307.8 4578.7 4578.8 4587.7 4589.5 4594.2 4641.4 4650.0 4655.1 4662.5 4663.8 5523.3 5526.8 5527.8 5529.6 5538.4 6727.2 6941.1 6963.5 6980.4 6999.2 1588.9 1605.6 1612.3 1616.6 1617.9 1012.8 1014.9 1031.9 1034.9 1039.0 6233.2 6365.9 6447.4 6448.2 6465.1 6080.1 6129.9 7280.1 7370.5 7385.0 6617.6 6647.2 6648.8 6660.8 6665.8 3819.1 3875.3 3875.5 3883.7 3885.9 7293.8 7590.2 7603.7 7633.1 7633.8 7424.7 7467.1 7476.7 7489.8 7491.3 7554.6 7571.5 7587.0 7590.1 7590.5 6598.7 7262.5 7267.5 7281.4 7316.2 6322.2 7063.2 7141.0 7142.2 7173.0 6172.3 6522.3 6968.0 7516.8 7605.1 4737.1 4806.6 4822.4 4824.6 4831.6 7213.6 7217.4 7231.8 7245.9 7254.4 6759.7 6900.4 6966.5 7033.4 7037.6 6902.2 6929.3 6974.6 6976.4 6986.4 5618.7 5740.4 6764.0 6841.1 6884.7 6987.6 6994.5 6999.8 7005.9 7019.6 5831.2 6393.9 6527.4 6624.2 6771.4 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - PROCESS | 1991 | [#5] yui.html Cycles:180 Average:18075.27 Median:63861.00 stddev:25225.03 (39.5%) stddev-sans-first:25262.03 02:35:10 INFO - PROCESS | 1991 | Values: 695.2 746.3 763.8 777.3 783.8 14950.5 15191.5 15195.0 15196.8 15225.8 13828.4 13864.4 13915.2 13927.5 14015.2 715.9 732.1 898.3 898.9 916.0 911.0 917.7 921.0 921.0 921.2 965.0 965.3 967.2 967.3 968.2 757.7 773.6 956.7 958.1 961.4 567.5 570.8 711.4 726.1 726.9 14849.9 14923.0 14941.9 14953.0 14976.4 12241.9 12344.8 12475.5 12564.3 12714.0 9835.7 9878.2 9900.8 9972.8 10247.5 3457.7 3505.9 3536.2 3554.7 3599.2 78686.0 81993.2 84094.0 85110.1 85244.0 9402.8 9412.6 9485.1 9735.9 9812.5 21621.8 21713.6 21742.1 21744.8 21766.2 7188.9 7344.1 7459.9 7523.0 7623.8 3451.8 3833.2 4048.8 4116.6 4119.5 3560.8 3600.6 3602.8 3605.7 3622.9 644.2 645.0 653.3 656.6 667.4 547.1 588.1 594.2 603.4 612.7 7985.1 8210.6 8262.9 8264.8 8336.3 515.6 564.4 582.7 592.7 616.6 3315.8 3358.9 3561.6 3784.0 3840.4 87729.6 87972.1 89477.6 89727.0 96759.5 71610.6 71972.6 72380.0 72512.3 72766.2 68633.0 69049.0 69372.7 69618.3 71492.3 7088.6 8188.2 8321.6 8387.0 8394.9 46219.0 47582.5 47996.8 48181.1 50303.2 63810.0 63912.0 66066.3 70417.6 71308.0 10979.1 11015.5 11328.2 11433.9 11606.1 11974.4 12064.5 12422.1 12722.6 12939.1 11417.0 11560.4 11683.9 11775.0 11807.9 11505.7 11506.8 11565.9 11670.9 11938.4 11234.8 11458.1 11709.1 11753.4 11771.8 9567.2 9653.7 9771.8 10004.2 10231.2 7578.7 9084.7 9163.6 9634.5 9646.7 02:35:10 INFO - PROCESS | 1991 | -------- Summary: end -------- 02:35:10 INFO - PROCESS | 1991 | 02:35:10 INFO - TEST-INFO | 1991: exit 0 02:35:10 INFO - TEST-OK | dromaeo_css | took 1113249ms 02:35:10 INFO - TEST-START | kraken 02:35:10 INFO - operating with platform_type : mac_ 02:35:10 INFO - Initialising browser for kraken test... 02:35:10 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpC8wvKf/profile http://localhost:50757/getInfo.html) 02:35:12 INFO - PROCESS | 1995 | __metrics Screen width/height:1600/1200 02:35:12 INFO - PROCESS | 1995 | colorDepth:24 02:35:12 INFO - PROCESS | 1995 | Browser inner width/height: 1024/689 02:35:12 INFO - PROCESS | 1995 | __metrics 02:35:13 INFO - PROCESS | 1995 | 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" 02:35:13 ERROR - PROCESS | 1995 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:35:13 INFO - TEST-INFO | 1995: exit 0 02:35:13 INFO - Browser initialized. 02:35:13 INFO - Running cycle 1/1 for kraken test... 02:35:13 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/T/tmpC8wvKf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:25 INFO - PROCESS | 1997 | RSS: Main: 244457472 02:35:25 INFO - PROCESS | 1997 | 02:35:28 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-beat-detection) 02:35:28 INFO - PROCESS | 1997 | RSS: Main: 290754560 02:35:28 INFO - PROCESS | 1997 | 02:35:31 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-dft) 02:35:32 INFO - PROCESS | 1997 | RSS: Main: 300957696 02:35:32 INFO - PROCESS | 1997 | 02:35:35 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-fft) 02:35:35 INFO - PROCESS | 1997 | RSS: Main: 285040640 02:35:35 INFO - PROCESS | 1997 | 02:35:37 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-oscillator) 02:35:38 INFO - PROCESS | 1997 | RSS: Main: 288178176 02:35:38 INFO - PROCESS | 1997 | 02:35:40 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:35:41 INFO - PROCESS | 1997 | RSS: Main: 289452032 02:35:41 INFO - PROCESS | 1997 | 02:35:43 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-darkroom) 02:35:44 INFO - PROCESS | 1997 | RSS: Main: 289251328 02:35:44 INFO - PROCESS | 1997 | 02:35:47 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-desaturate) 02:35:48 INFO - PROCESS | 1997 | RSS: Main: 289497088 02:35:48 INFO - PROCESS | 1997 | 02:35:50 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50757/tests/kraken/driver.html?testName=json-parse-financial) 02:35:51 INFO - PROCESS | 1997 | RSS: Main: 289886208 02:35:51 INFO - PROCESS | 1997 | 02:35:52 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:35:53 INFO - PROCESS | 1997 | RSS: Main: 323260416 02:35:53 INFO - PROCESS | 1997 | 02:35:55 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:56 INFO - PROCESS | 1997 | RSS: Main: 322596864 02:35:56 INFO - PROCESS | 1997 | 02:35:58 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:58 INFO - PROCESS | 1997 | RSS: Main: 331091968 02:35:58 INFO - PROCESS | 1997 | 02:36:01 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:36:01 INFO - PROCESS | 1997 | RSS: Main: 332275712 02:36:01 INFO - PROCESS | 1997 | 02:36:04 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:36:04 INFO - PROCESS | 1997 | RSS: Main: 332226560 02:36:04 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50757/tests/kraken/driver.html?testName=ai-astar) 02:36:06 INFO - PROCESS | 1997 | RSS: Main: 395182080 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | __start_tp_report 02:36:06 INFO - PROCESS | 1997 | _x_x_mozilla_page_load 02:36:06 INFO - PROCESS | 1997 | _x_x_mozilla_page_load_details 02:36:06 INFO - PROCESS | 1997 | |i|pagename|runs| 02:36:06 INFO - PROCESS | 1997 | |0;ai-astar;112;108;111;111;111;112;115;111;111;111 02:36:06 INFO - PROCESS | 1997 | |1;audio-beat-detection;156;121;145;161;119;141;139;130;195;153 02:36:06 INFO - PROCESS | 1997 | |2;audio-dft;182;184;185;183;185;184;185;181;182;182 02:36:06 INFO - PROCESS | 1997 | |3;audio-fft;74;74;86;79;57;57;59;94;112;55 02:36:06 INFO - PROCESS | 1997 | |4;audio-oscillator;94;92;130;78;80;87;117;80;80;121 02:36:06 INFO - PROCESS | 1997 | |5;imaging-gaussian-blur;88;85;89;85;88;84;88;89;89;85 02:36:06 INFO - PROCESS | 1997 | |6;imaging-darkroom;93;93;93;93;93;93;93;103;136;93 02:36:06 INFO - PROCESS | 1997 | |7;imaging-desaturate;84;83;86;84;88;84;83;85;86;85 02:36:06 INFO - PROCESS | 1997 | |8;json-parse-financial;55;54;54;55;55;56;54;65;55;52 02:36:06 INFO - PROCESS | 1997 | |9;json-stringify-tinderbox;65;64;73;79;71;70;66;66;66;90 02:36:06 INFO - PROCESS | 1997 | |10;stanford-crypto-aes;84;84;84;84;83;84;82;82;85;85 02:36:06 INFO - PROCESS | 1997 | |11;stanford-crypto-ccm;124;122;123;137;140;130;108;126;122;122 02:36:06 INFO - PROCESS | 1997 | |12;stanford-crypto-pbkdf2;179;135;140;140;141;129;139;139;140;140 02:36:06 INFO - PROCESS | 1997 | |13;stanford-crypto-sha256-iterative;68;67;71;68;67;68;66;67;67;67 02:36:06 INFO - PROCESS | 1997 | __end_tp_report 02:36:06 INFO - PROCESS | 1997 | __start_cc_report 02:36:06 INFO - PROCESS | 1997 | _x_x_mozilla_cycle_collect,1291 02:36:06 INFO - PROCESS | 1997 | __end_cc_report 02:36:06 INFO - PROCESS | 1997 | __startTimestamp1459330566937__endTimestamp 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | ------- Summary: start ------- 02:36:06 INFO - PROCESS | 1997 | Number of tests: 14 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 02:36:06 INFO - PROCESS | 1997 | Values: 112.0 108.0 111.0 111.0 111.0 112.0 115.0 111.0 111.0 111.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:149.00 stddev:22.26 (14.9%) stddev-sans-first:23.32 02:36:06 INFO - PROCESS | 1997 | Values: 156.0 121.0 145.0 161.0 119.0 141.0 139.0 130.0 195.0 153.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.49 (0.8%) stddev-sans-first:1.51 02:36:06 INFO - PROCESS | 1997 | Values: 182.0 184.0 185.0 183.0 185.0 184.0 185.0 181.0 182.0 182.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#3] audio-fft Cycles:10 Average:74.70 Median:74.00 stddev:18.77 (25.4%) stddev-sans-first:19.91 02:36:06 INFO - PROCESS | 1997 | Values: 74.0 74.0 86.0 79.0 57.0 57.0 59.0 94.0 112.0 55.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:80.00 stddev:19.48 (24.3%) stddev-sans-first:20.65 02:36:06 INFO - PROCESS | 1997 | Values: 94.0 92.0 130.0 78.0 80.0 87.0 117.0 80.0 80.0 121.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:2.00 (2.3%) stddev-sans-first:2.09 02:36:06 INFO - PROCESS | 1997 | Values: 88.0 85.0 89.0 85.0 88.0 84.0 88.0 89.0 89.0 85.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:93.00 stddev:13.61 (14.6%) stddev-sans-first:14.30 02:36:06 INFO - PROCESS | 1997 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 103.0 136.0 93.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.55 (1.8%) stddev-sans-first:1.62 02:36:06 INFO - PROCESS | 1997 | Values: 84.0 83.0 86.0 84.0 88.0 84.0 83.0 85.0 86.0 85.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.50 (6.4%) stddev-sans-first:3.71 02:36:06 INFO - PROCESS | 1997 | Values: 55.0 54.0 54.0 55.0 55.0 56.0 54.0 65.0 55.0 52.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:70.50 stddev:8.10 (11.5%) stddev-sans-first:8.29 02:36:06 INFO - PROCESS | 1997 | Values: 65.0 64.0 73.0 79.0 71.0 70.0 66.0 66.0 66.0 90.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 02:36:06 INFO - PROCESS | 1997 | Values: 84.0 84.0 84.0 84.0 83.0 84.0 82.0 82.0 85.0 85.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:125.00 stddev:8.91 (7.1%) stddev-sans-first:9.44 02:36:06 INFO - PROCESS | 1997 | Values: 124.0 122.0 123.0 137.0 140.0 130.0 108.0 126.0 122.0 122.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:140.00 stddev:13.42 (9.6%) stddev-sans-first:3.82 02:36:06 INFO - PROCESS | 1997 | Values: 179.0 135.0 140.0 140.0 141.0 129.0 139.0 139.0 140.0 140.0 02:36:06 INFO - PROCESS | 1997 | 02:36:06 INFO - PROCESS | 1997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 02:36:06 INFO - PROCESS | 1997 | Values: 68.0 67.0 71.0 68.0 67.0 68.0 66.0 67.0 67.0 67.0 02:36:06 INFO - PROCESS | 1997 | -------- Summary: end -------- 02:36:06 INFO - PROCESS | 1997 | 02:36:07 INFO - TEST-INFO | 1997: exit 0 02:36:07 INFO - TEST-OK | kraken | took 56892ms 02:36:07 INFO - SUITE-END | took 1170s 02:36:08 INFO - Completed test suite (00:19:30) 02:36:08 INFO - javascript benchmark 02:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3403.1322012886712, 3430.6912377886, 3467.9769468006934, 3468.5952189363315, 3491.4413693808997, 5530.5299049580835, 5597.132444471104, 5636.661800291985, 5651.519620832229, 5663.037283661783, 5608.270924779773, 5665.943340566593, 5668.178114173453, 5684.744186511606, 5684.971575142129, 5113.284140220372, 5126.897462050757, 5136.460671629481, 5152.793888244484, 5199.194124910626, 5213.374395072597, 5221.216817477371, 5225.634205605609, 5225.817096401626, 5230.058589453897, 5132.358455193101, 5162.303089082963, 5172.19830926207, 5192.974035129819, 5200.791968321281, 4450.688451808374, 5183.429822719517, 5239.449857764956, 5239.659422137549, 5296.947030529684, 5045.596352291808, 5059.3169922060415, 5079.8222062228015, 5160.406553246387, 5162.819301324474, 5583.972080139614, 5605.411431799643, 5618.606697531174, 5639.210510528488, 5711.657300561938, 6206.224221972254, 6206.317305096436, 6207.099970504251, 6212.099245609361, 6240.594361366542, 6076.684103182968, 6121.0, 6228.5017198624, 6299.811005669837, 6312.147860038928, 5793.8841223175305, 5806.477417032445, 5812.505936995318, 5813.82558523245, 5848.88302233953, 5914.940850591525, 5955.719520303156, 6223.813285601439, 6243.719032643542, 6252.812415627538, 5045.0, 5900.64596124234, 6015.428534289235, 6098.311206366174, 6109.816705498753, 6129.478994285536, 6189.412005859436, 6191.442770150708, 6201.627902325875, 6205.131281620576, 6099.359567245464, 6170.0, 6192.59748116371, 6196.535259855529, 6216.564840461215, 5960.791372302036, 6075.179850720185, 6101.792513241505, 6209.844753881189, 6234.844128896814, 4863.683860549053, 4877.414710234723, 4880.707157570557, 4908.9754551227015, 4948.628852836052, 4399.802008909607, 4403.493598236179, 4407.735535867858, 4425.601695847389, 4460.799264033127, 5608.635438696471, 5652.830415087554, 5706.828795136153, 5755.021646320136, 5794.101914203306, 6204.472619827366, 6225.066240063936, 6234.345393733593, 6234.688265586793, 6236.75052997875, 5677.51741102011, 5720.971395143081, 5730.598858079978, 5739.0, 5765.827025189251, 5256.211568264791, 5288.444713305124, 5351.625386222927, 5352.197170424468, 5392.811251606254, 6265.780697675559, 6286.18279623646, 6290.433860952537, 6293.307736148929, 6299.338569450142, 6098.67428752872, 6154.353792851686, 6235.376462353728, 6235.906461403173, 6257.124002639725, 6172.5679202457195, 6234.937650623617, 6259.812205633838, 6276.497880169484, 6290.905636415366, 6117.755289788359, 6168.25980882297, 6170.9074363885475, 6191.288001879661, 6202.937970620236, 6043.848903777441, 6115.575014303803, 6260.718267677874, 6280.685965701605, 6300.275468321019, 6052.969735151296, 6111.98679349419, 6124.106319906264, 6137.376985335611, 6141.232345956755, 6046.486048685735, 6047.365026672312, 6079.513638908965, 6080.209572755691, 6097.908531372122, 5808.30300363959, 5859.150423188699, 5877.735501902339, 5951.256092988377, 5976.372480889618, 5916.585838991229, 6070.757169713162, 6091.177691011834, 6104.4505994460715, 6108.389161083856, 5849.444302791228, 5900.64596124234, 5912.290525137011, 5922.111683247547, 5926.555508336978], "unit": "score", "name": "dojo.html", "value": 5663.664722467924}, {"lowerIsBetter": false, "replicates": [462.09890713109445, 582.3215953414273, 582.9562782791289, 642.2934771751075, 647.8088963755691, 24346.63480047801, 38078.66724664637, 38425.23149537011, 38431.0, 38440.423393649115, 39625.20749585007, 40308.79845600775, 40422.19155616886, 40426.0, 40465.19069618613, 9486.288528360366, 9718.951405242964, 9729.027097290285, 9741.366811157288, 9758.072983066597, 9547.093026162504, 9688.467134307646, 9702.854457183113, 9717.222622190244, 9722.222222222204, 9664.226861851035, 9853.162481189107, 9887.258455615822, 9888.258380621446, 9894.85157722631, 9755.804883902318, 9843.90156098437, 9848.655297064568, 9863.457509836991, 9868.013198680146, 9608.75978100553, 9732.659356922473, 9746.074122958307, 9753.21974242059, 9761.65834195807, 40495.59504404948, 40791.388129178085, 40806.795966020276, 40850.0, 41063.17873642511, 3225.5322978168033, 3243.2540515681526, 3255.0723043932603, 3267.9346413071844, 3485.0416135562923, 27682.861585691942, 27808.58287125695, 28001.159965201077, 28277.57583636247, 28416.431671366663, 2544.300317412726, 2699.25770413136, 2768.806183567151, 2774.861256937145, 2824.4068745563454, 473914.0, 474576.0, 476805.0, 480877.0, 481647.59176203894, 44291.0, 44754.55245447504, 44947.101057979315, 67452.3254767446, 68100.6594967022, 43795.78102109469, 43863.78068109703, 44106.338404923954, 44150.89622759393, 44238.33642495365, 15312.617184570476, 15502.224888755518, 15507.224638768017, 15522.689546209012, 15529.689406211812, 10354.53404596795, 12440.0, 12509.43707533145, 12515.99872010237, 12521.499140034479, 14519.0, 14524.346404411826, 14565.198914059829, 14573.344199511048, 14615.196164211071, 6242.781502647385, 6364.1408409865, 6412.358764123644, 6414.518911081687, 6416.13382193398, 955.6559638530124, 956.7177682583655, 962.3311798300114, 965.4207475514635, 1145.4673576786834, 23859.880700596732, 28211.858940705166, 29558.0, 29565.85217073901, 29699.10902672923, 1053.8103141434462, 1078.5524007536785, 1151.7178291318512, 1163.837062811207, 1267.7718010758151, 14631.561053168421, 14666.779998300033, 14682.119072855663, 15039.323230454656, 15144.394224230908, 525655.0, 532432.0, 532533.0, 533573.0, 533616.0, 57465.13802292969, 57959.999999999156, 58139.70930145322, 58155.41844581585, 58176.70911645499, 1142.4344949250174, 1367.8495365509984, 1458.2562892924473, 1474.837767845536, 1518.422999260274, 24995.87502062478, 26559.60160597554, 28001.43997120087, 28449.167920576645, 28509.857450712614, 43256.56743432651, 43581.56418435902, 43702.344464832415, 43833.56166438295, 43865.90335241645, 368821.0, 369728.0, 371999.0, 373297.0, 373430.0, 32811.70318077712, 42067.7896610515, 43561.78219109011, 44047.77976110099, 44101.77949110234, 41392.586074138875, 42536.93657658583, 44564.77717611521, 46623.0, 47365.526344736114, 34074.31851362909, 35174.29651407008, 35451.29097417986, 35932.28135437329, 35968.460473092404, 34121.0, 34478.31043379169, 34625.0, 35337.293254135286, 35352.823235883654, 35181.120471988404, 35447.0, 35477.645223547435, 35482.29035419329, 36670.266594668494, 28309.716902830707, 30356.089317320515, 30468.695313046584, 30672.079837604906, 30823.691763082978, 19156.46528225196, 23383.88308058449, 23397.363916296326, 23399.76600233976, 23822.404439889142], "unit": "score", "name": "ext.html", "value": 18799.527804822563}, {"lowerIsBetter": false, "replicates": [356.1274876552446, 358.32276996476656, 360.27584555044353, 370.3370965970912, 371.5096073183397, 19414.417567472963, 19980.50048748782, 20550.38348849535, 21049.789502104974, 21130.57738845222, 19935.202591896308, 20295.898520507413, 21061.894690526566, 21196.894015529902, 21197.788022119774, 5541.168824676301, 5679.233303504016, 5720.713964301789, 5745.597808153431, 5746.224259724946, 4048.7773172475504, 4336.783160841961, 6094.421030002142, 6354.046892966046, 6398.584092034026, 6216.1918950536365, 6308.589941653778, 6309.116723658692, 6323.873522529547, 6329.58857674252, 5045.596352291826, 5067.315912351823, 6269.96865015672, 6270.122182894398, 6298.212723409574, 3580.104973756561, 5092.643514953955, 5486.1222204447495, 5495.972520137374, 5496.148097044925, 24504.387390315205, 25102.121425750192, 25869.61195582049, 25916.8704156478, 25920.96316147352, 2008.3974807557674, 2212.9225477108225, 2256.3231030690727, 2262.908455974058, 2267.115824828318, 12361.258324500559, 14444.0, 14514.419423223058, 15018.849811501854, 15538.844611553854, 1728.7752592163065, 1775.343123044469, 1782.322717367392, 1787.2136260045668, 1793.5695433095964, 83040.0, 101588.0, 101653.0, 103138.0, 105515.94484055138, 10203.081722644998, 10263.486825658687, 10592.152627789912, 10614.628488002883, 10744.710634723882, 13126.015548833875, 13132.949364050854, 13174.670633234246, 13185.868141318655, 13205.207687538586, 8386.79033024167, 8538.274246688978, 8600.354973377021, 8680.30557555394, 8711.303095752324, 7176.677049532784, 8727.956360218159, 8786.428882122642, 8830.337724670675, 8883.866741998876, 6124.418180272867, 6208.503319734501, 6222.906656400158, 6237.688115594202, 6325.557210995278, 1449.0870751426535, 1662.5843539115222, 1744.5551384396897, 1745.1361576019951, 1826.7807863056253, 930.8417569013284, 953.9618415263312, 968.3415277611292, 1011.4234886114843, 1079.7030816525519, 17149.742753858704, 19166.137523811463, 19989.0, 20080.09639566223, 20084.288621035972, 855.5551113420986, 921.6267411698273, 939.7782882253043, 956.7368973532334, 972.9221662267001, 10739.731506712238, 11134.0, 11145.387003714874, 11175.83236251457, 11411.315321080761, 333243.0, 443444.0, 444248.0, 625547.0, 626165.0, 107849.0, 108295.0, 108301.0, 110810.44594776974, 111974.0, 1001.5092604623827, 1018.4856647393019, 1042.166266986408, 1042.338115296792, 1055.2982266792496, 17762.46712598624, 18002.36991705284, 18271.36050238235, 18393.356232531798, 18669.71995420097, 42445.57554424416, 43980.58106804157, 47654.761726191144, 48047.79880503016, 48216.79458013578, 56816.0, 72261.0, 72585.0, 72746.63626681833, 74067.8889816664, 7555.09338879338, 7592.734254301073, 7639.503432276884, 7760.922390776246, 7984.20157984197, 10117.747056323651, 12159.0, 12162.817557736818, 12280.140390172603, 12524.0, 10119.494025298558, 10632.574697012033, 10666.746522526913, 10869.29349592274, 11029.944850276019, 10659.680209593724, 10728.73178170552, 10802.67591972242, 11008.504617292401, 11116.833247501456, 9111.772205694646, 10947.671569852917, 10963.616273430393, 11317.773644526898, 11425.657230283105, 7493.325600695964, 7722.575258360619, 7754.534727916343, 7841.137474877873, 8119.959400202961, 8266.462679925786, 10077.949610251902, 10802.405867677038, 11389.259698119597, 11417.60038398652], "unit": "score", "name": "jquery.html", "value": 9315.13829819047}, {"lowerIsBetter": false, "replicates": [1446.7902154187636, 1584.6117701163214, 1619.481765834933, 1908.9140988655508, 2041.520242742956, 8061.87907181392, 8281.710140145096, 8630.352723545744, 8899.288056955444, 8968.10318968103, 8722.25860801831, 8788.91211087889, 8887.644494220223, 8896.421732587378, 8906.821863562725, 2200.90095945682, 2411.0, 2456.427886152859, 2486.080150344375, 2490.68866391701, 2501.8123640727017, 2507.272890861657, 2507.7993760499207, 2507.912223072193, 2510.259473455326, 2411.7347091819884, 2426.9514609707794, 2467.5064987002584, 2486.639437281593, 2487.776100150986, 2449.640449550499, 2469.4196863737006, 2483.1681386735463, 2491.231225829663, 2493.0775613023116, 2421.3825474504065, 2473.4929339485543, 2474.552386853693, 2482.2305085423395, 2482.640017197496, 8909.242714369286, 9010.098990101003, 9011.774705632346, 9012.0086790453, 9015.323850711156, 5492.286002819648, 5607.943920560783, 5638.577106717013, 5649.463300986441, 5673.063944449161, 3636.236390358028, 3713.4801127842125, 3793.013816407726, 3811.1805961718364, 3814.828332725034, 1039.4335087377397, 1057.6509751781894, 1061.925665203436, 1067.626330784227, 1077.6659235636978, 12172.81740773889, 12173.452194651174, 12180.20828646144, 12193.634190974373, 12251.142420030601, 4843.055604157155, 4875.975620121877, 4974.129527332702, 4992.775325110379, 5014.874628134326, 10303.227257955683, 10320.638777642747, 10325.896741032644, 10327.431991240554, 10329.535170917326, 5586.273784408001, 5603.019471592455, 5612.5229355504425, 5617.073182924772, 5628.634138780966, 4199.559046300155, 4444.266695995125, 4597.0, 4763.476017638057, 4984.626153038536, 3846.3268927938057, 3899.512560929884, 3914.5889681583594, 3946.210757848442, 3955.110100227426, 1282.4421376701164, 1302.5896842494583, 1305.8041293806004, 1314.2574445438297, 1318.7494376068516, 1063.984040239397, 1089.841972913939, 1106.43571778392, 1417.4684493315008, 1418.432626949208, 8249.175082491704, 8251.0, 8317.293030092389, 8358.540280284642, 8358.665653373797, 454.8862784303924, 520.971346575942, 535.1357557544537, 537.704262655538, 538.64449463354, 6192.721327540272, 6204.162438070893, 6260.686965651699, 6271.498280137578, 6284.12022316876, 10502.422366769748, 10868.0, 10934.890651093547, 11053.447327633587, 11068.114550835913, 10687.519061642244, 10746.355218686904, 10804.891951080388, 10858.131349492021, 10931.125509959184, 8365.24712775841, 8396.286315663116, 8412.8317433651, 8436.704715334934, 8469.153084691605, 7769.72805951789, 7972.043354797462, 7991.3606911448105, 8005.879911801444, 8078.87881681787, 9438.95280523593, 9638.662646807328, 9699.806003879741, 9716.902830971883, 9734.659286924923, 9048.638054477748, 9545.61817527319, 9865.309428339948, 10003.749906252402, 10278.383297002203, 6783.966080169567, 6796.72813087471, 7023.964880175567, 7607.961960190164, 7668.5782281975025, 7761.9611901940125, 7832.84334313322, 8103.189681031849, 8116.837663246584, 8123.7156699515235, 7188.676509556978, 7291.52605080668, 7309.671064801991, 7428.997085393619, 7457.6271186441545, 7174.031505746658, 7185.209626940928, 7222.819429514304, 7332.743353982585, 7357.153927298215, 7400.296971787671, 7652.387808975157, 7707.88438173439, 7720.729774457867, 7723.652435640522, 6962.268961758942, 6975.930240697731, 7035.718571257093, 7036.788896333118, 7040.929590704232, 7050.506464547432, 7089.149302083783, 7105.147382314155, 7126.964365178141, 7141.464390170862], "unit": "score", "name": "mootools.html", "value": 4866.366523786277}, {"lowerIsBetter": false, "replicates": [294.3627047442287, 328.2155648001277, 330.39207857542124, 335.0, 337.2428897125953, 5092.847214583564, 6255.530835187362, 6559.048937904001, 6580.374864387887, 6621.966890165554, 6348.206474190726, 6456.257530384008, 6508.153939987807, 6521.413072823445, 6544.509161812859, 3872.4772155759033, 4586.082783443308, 4699.0, 4717.669763116583, 4868.123737727207, 3772.830222639988, 4756.0, 4801.663883528155, 4805.9426926076385, 4814.566688997989, 4728.881777955561, 4738.47876733559, 4746.715197088186, 4758.643101767364, 4769.022350418173, 4546.909061818778, 4610.585047345755, 4735.313379559944, 4766.142094423002, 4778.474367819537, 4064.5935406459116, 4081.306177949726, 4082.8979275518054, 4088.8568900088353, 4093.2018256440006, 6240.313565507836, 6241.282252540925, 6249.9062514062325, 6270.216222972129, 6283.3088360280335, 4590.724556526619, 4667.4632417272105, 5652.463016013472, 5684.573656975702, 5695.829125126253, 6910.378065974087, 6927.861442771166, 6944.895826562605, 6952.409045231161, 6953.235144134142, 4308.9353659695125, 4494.865154045384, 4496.100779844044, 4638.512956139591, 4645.465771436295, 5903.881922361572, 7210.0, 7250.927490725078, 7286.854262914765, 7307.817304567375, 4578.725276483422, 4578.793954272066, 4587.6788624795945, 4589.472210695746, 4594.218982772936, 4641.419822522184, 4649.976750116228, 4655.068986202773, 4662.487126416091, 4663.790129444184, 5523.337199536081, 5526.834194974077, 5527.806526771544, 5529.557635389159, 5538.390777014525, 6727.192736871509, 6941.132358455193, 6963.547369420971, 6980.371766540934, 6999.195092564319, 1588.9443869464512, 1605.6387312854747, 1612.3469994652185, 1616.6200942778437, 1617.8624816890697, 1012.8480727890728, 1014.8731408573929, 1031.9071283584362, 1034.8654674892216, 1038.9532471038822, 6233.161217440866, 6365.936340636535, 6447.3552644735155, 6448.193975753031, 6465.094886715863, 6080.14877917092, 6129.877402451926, 7280.126384833854, 7370.484066115428, 7385.0, 6617.636030018395, 6647.235567909753, 6648.83377915556, 6660.766873159513, 6665.766698165541, 3819.0643292393543, 3875.2636998970106, 3875.496185495924, 3883.7281390302974, 3885.8834234972996, 7293.817654558572, 7590.240975902476, 7603.695852165962, 7633.122190948001, 7633.847323053508, 7424.740134095281, 7467.066616672916, 7476.70093196266, 7489.812754681067, 7491.288327608869, 7554.584497852671, 7571.545707257582, 7587.013688220496, 7590.051243594551, 7590.544567325978, 6598.670066496752, 7262.455315851226, 7267.527610705287, 7281.381082608038, 7316.1952185258515, 6322.178116844781, 7063.223045465097, 7141.0, 7142.178649455379, 7173.031640728644, 6172.259328880563, 6522.28254891952, 6968.024476573182, 7516.8496630066, 7605.087389513294, 4737.076270127292, 4806.591439727662, 4822.397200349957, 4824.589909857561, 4831.589314908272, 7213.567185968858, 7217.386522145676, 7231.819204519929, 7245.8768890822, 7254.419646428379, 6759.723025961461, 6900.378965893094, 6966.5471744336455, 7033.402160816388, 7037.648117594203, 6902.24075351721, 6929.272426395358, 6974.58152510851, 6976.407005404394, 6986.406155476841, 5618.7190640467, 5740.397258287987, 6764.0, 6841.144856892888, 6884.724611015704, 6987.567548652616, 6994.510384273052, 6999.790006299819, 7005.929940700732, 7019.613921234381, 5831.192330377597, 6393.881070812497, 6527.412532872065, 6624.238212605612, 6771.424428923597], "unit": "score", "name": "prototype.html", "value": 5040.28517771075}, {"lowerIsBetter": false, "replicates": [695.2005194026868, 746.264929044891, 763.8281386687993, 777.3237283563299, 783.8118851475648, 14950.476733314335, 15191.544253672393, 15195.0, 15196.848031519681, 15225.771613425808, 13828.377723002464, 13864.445422183126, 13915.234662093606, 13927.512537061204, 14015.15909045458, 715.8997740316333, 732.0848938826467, 898.294838551737, 898.9190972812446, 915.9924083508121, 910.9726708198765, 917.6788124156525, 920.9677661281856, 921.0375157959948, 921.2031592672324, 964.9807003859919, 965.290511474066, 967.1585720423242, 967.3470407474962, 968.1915600473613, 757.7120694136192, 773.6479901644739, 956.6747305915987, 958.108958668438, 961.3943215774052, 567.4779203133086, 570.8116321613858, 711.434409644334, 726.0815068937798, 726.9491135620509, 14849.851501484954, 14923.0, 14941.925290373587, 14953.0, 14976.400943962228, 12241.938790305992, 12344.75310493785, 12475.50097996079, 12564.308963007032, 12714.0, 9835.704928852147, 9878.236668157617, 9900.801983960353, 9972.750681232954, 10247.538860751283, 3457.723382129449, 3505.8948231553095, 3536.1513236822975, 3554.733394995386, 3599.208174201671, 78686.0, 81993.18006819914, 84093.99999999939, 85110.14889851084, 85244.0, 9402.811943761086, 9412.623495060257, 9485.098915603006, 9735.853962190573, 9812.509374531388, 21621.783782161976, 21713.56572868534, 21742.13031478723, 21744.78255217459, 21766.238181663564, 7188.892166617505, 7344.081989751281, 7459.888101678479, 7523.0, 7623.771286861403, 3451.775634583744, 3833.15670552478, 4048.8380464781667, 4116.567760385176, 4119.505659320901, 3560.7863528187872, 3600.6399360064306, 3602.819859007039, 3605.7115430765475, 3622.9094272643397, 644.22049320322, 645.0197892470165, 653.2683394597985, 656.6454114777966, 667.3693359775064, 547.1300631995147, 588.106078760282, 594.180031556458, 603.3544107804607, 612.6599737145838, 7985.121636619967, 8210.58947052657, 8262.876056859152, 8264.8347033059, 8336.333093352518, 515.6364762842187, 564.350996354196, 582.6620560075146, 592.6503363015842, 616.6392660293689, 3315.8063097284958, 3358.899233023013, 3561.554805649294, 3783.9621603784162, 3840.385538313912, 87729.56135219283, 87972.0825125729, 89477.55261223653, 89727.0, 96759.51620241995, 71610.64194679097, 71972.64013679897, 72380.0, 72512.2748772516, 72766.18084547823, 68633.0, 69049.0, 69372.653136735, 69618.3038169622, 71492.2850771496, 7088.574685518885, 8188.181181881764, 8321.583920803814, 8386.958065209636, 8394.916050839414, 46219.0, 47582.52417475781, 47996.760016199696, 48181.072757090726, 50303.245451317525, 63810.0, 63912.0, 66066.33933660602, 70417.64791176216, 71308.0, 10979.121670266519, 11015.504302306255, 11328.150388721044, 11433.885661143282, 11606.071514279007, 11974.401279936143, 12064.457099430721, 12422.130450868352, 12722.554710585086, 12939.094263401472, 11417.0, 11560.421978900853, 11683.88316116862, 11775.0, 11807.881921180679, 11505.712357191138, 11506.76986460283, 11565.942170289094, 11670.94164529172, 11938.403079846146, 11234.810305005652, 11458.140639452242, 11709.121815863675, 11753.412329383325, 11771.764564708828, 9567.186789123003, 9653.662121825982, 9771.75570610712, 10004.249681273788, 10231.181505479395, 7578.696852125853, 9084.72813806081, 9163.587638556148, 9634.518274086407, 9646.711438754943], "unit": "score", "name": "yui.html", "value": 6851.102208263957}], "name": "dromaeo_css", "value": 7418.475776923374}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 111.0, 112.0, 115.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 145.0, 161.0, 119.0, 141.0, 139.0, 130.0, 195.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [182.0, 184.0, 185.0, 183.0, 185.0, 184.0, 185.0, 181.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 86.0, 79.0, 57.0, 57.0, 59.0, 94.0, 112.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.7}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 130.0, 78.0, 80.0, 87.0, 117.0, 80.0, 80.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 95.9}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 85.0, 88.0, 84.0, 88.0, 89.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 103.0, 136.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 98.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 86.0, 84.0, 88.0, 84.0, 83.0, 85.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 84.8}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 55.0, 55.0, 56.0, 54.0, 65.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 73.0, 79.0, 71.0, 70.0, 66.0, 66.0, 66.0, 90.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 82.0, 82.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 123.0, 137.0, 140.0, 130.0, 108.0, 126.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [179.0, 135.0, 140.0, 140.0, 141.0, 129.0, 139.0, 139.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 71.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1426.7}]} 02:36:08 INFO - Return code: 0 02:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:36:08 ERROR - # TBPL SUCCESS # 02:36:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:08 INFO - 2016-03-30 02:36:08.221 screenresolution[2001:30156] starting screenresolution argv=screenresolution get 02:36:08 INFO - 2016-03-30 02:36:08.223 screenresolution[2001:30156] Display 0: 1600x1200x32@60 02:36:08 INFO - 2016-03-30 02:36:08.229 screenresolution[2002:30159] starting screenresolution argv=screenresolution list 02:36:08 INFO - Available Modes on Display 0 02:36:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:08 INFO - Intel Iris: 02:36:08 INFO - Chipset Model: Intel Iris 02:36:08 INFO - Type: GPU 02:36:08 INFO - Bus: Built-In 02:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:08 INFO - Vendor: Intel (0x8086) 02:36:08 INFO - Device ID: 0x0a2e 02:36:08 INFO - Revision ID: 0x0009 02:36:08 INFO - Displays: 02:36:08 INFO - Display: 02:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:08 INFO - Display Serial Number: 1600x1200 60 02:36:08 INFO - Main Display: Yes 02:36:08 INFO - Mirror: Off 02:36:08 INFO - Online: Yes 02:36:08 INFO - Rotation: Supported 02:36:08 INFO - Return code: 0 02:36:08 INFO - Running post-action listener: _resource_record_post_action 02:36:08 INFO - Running post-run listener: _resource_record_post_run 02:36:09 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2486272; Write bytes: 705909760; Read time: 41; Write time: 1877 02:36:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398219776; Write bytes: 393581568; Read time: 30172; Write time: 718 02:36:09 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2486272; Write bytes: 299134976; Read time: 41; Write time: 1120 02:36:09 INFO - Running post-run listener: _upload_blobber_files 02:36:09 INFO - Blob upload gear active. 02:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:36:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:11 INFO - (blobuploader) - INFO - Done attempting. 02:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:12 INFO - (blobuploader) - INFO - Done attempting. 02:36:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:36:12 INFO - Return code: 0 02:36:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:36:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:36:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459e94b1e459df5b949073f999424a5a76f9ea71b1d0ba1d777274f135794200631f0e033f2dd5afb3675f17ba914a784e02f2d1accdc4e6c64b24b82f984fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dad19997dce90028da48afe594b6d3fca80bb58260d0b1bb1b4f7c48ce5bf7d0d5cf5f4fb9b46a48d51e05ff930ed3c8f647c039934dd6e83542855f7eb9a525"} 02:36:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:36:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:36:12 INFO - Contents: 02:36:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/459e94b1e459df5b949073f999424a5a76f9ea71b1d0ba1d777274f135794200631f0e033f2dd5afb3675f17ba914a784e02f2d1accdc4e6c64b24b82f984fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dad19997dce90028da48afe594b6d3fca80bb58260d0b1bb1b4f7c48ce5bf7d0d5cf5f4fb9b46a48d51e05ff930ed3c8f647c039934dd6e83542855f7eb9a525"} 02:36:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:36:12 INFO - Copying logs to upload dir... 02:36:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:36:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.578611 ========= master_lag: -0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-03-30 02:36:11.715907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 02:36:11.719953) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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/459e94b1e459df5b949073f999424a5a76f9ea71b1d0ba1d777274f135794200631f0e033f2dd5afb3675f17ba914a784e02f2d1accdc4e6c64b24b82f984fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dad19997dce90028da48afe594b6d3fca80bb58260d0b1bb1b4f7c48ce5bf7d0d5cf5f4fb9b46a48d51e05ff930ed3c8f647c039934dd6e83542855f7eb9a525"} build_url:https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010623 build_url: 'https://queue.taskcluster.net/v1/task/BWm8_MdER72OixuEticsCQ/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/459e94b1e459df5b949073f999424a5a76f9ea71b1d0ba1d777274f135794200631f0e033f2dd5afb3675f17ba914a784e02f2d1accdc4e6c64b24b82f984fbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dad19997dce90028da48afe594b6d3fca80bb58260d0b1bb1b4f7c48ce5bf7d0d5cf5f4fb9b46a48d51e05ff930ed3c8f647c039934dd6e83542855f7eb9a525"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 02:36:11.748691) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:36:11.748990) ========= 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.JtL1C8wRqy/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.c66dC3MDFR/Listeners TMPDIR=/var/folders/b2/qr0y6yxn2s32nywswzqqd0bc00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 02:36:11.798438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 02:36:11.798785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 02:36:11.799937) ========= ========= Total master_lag: -0.15 =========