builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0144 starttime: 1458817558.98 results: success (0) buildid: 20160324031044 builduid: 6de99a595a5c4c43b21cdaa6dac173b1 revision: faa774eaf02c4128d0a80ad4d465c368c0cf023f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:58.979135) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:58.979485) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:58.979757) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005497 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.060212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.060504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.078641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.078912) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.128093) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.128375) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.128697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.128981) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-24 04:05:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-03-24 04:05:59 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.565552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.710240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.710547) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.026229 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:05:59.761555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 04:05:59.761874) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev faa774eaf02c4128d0a80ad4d465c368c0cf023f --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 faa774eaf02c4128d0a80ad4d465c368c0cf023f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-24 04:05:59,836 truncating revision to first 12 chars 2016-03-24 04:05:59,837 Setting DEBUG logging. 2016-03-24 04:05:59,837 attempt 1/10 2016-03-24 04:05:59,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/faa774eaf02c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 04:06:00,518 unpacking tar archive at: fx-team-faa774eaf02c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.127919 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 04:06:00.909410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 04:06:00.909740) ========= echo faa774eaf02c4128d0a80ad4d465c368c0cf023f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'faa774eaf02c4128d0a80ad4d465c368c0cf023f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 faa774eaf02c4128d0a80ad4d465c368c0cf023f program finished with exit code 0 elapsedTime=0.005284 script_repo_revision: 'faa774eaf02c4128d0a80ad4d465c368c0cf023f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 04:06:00.967209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 04:06:00.967494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 04:06:00.996229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-03-24 04:06:00.996524) ========= /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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:01 INFO - MultiFileLogger online at 20160324 04:06:01 in /builds/slave/test 04:06:01 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 04:06:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:01 INFO - {'append_to_log': False, 04:06:01 INFO - 'base_work_dir': '/builds/slave/test', 04:06:01 INFO - 'blob_upload_branch': 'Fx-Team', 04:06:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:01 INFO - 'branch': 'Fx-Team', 04:06:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:01 INFO - 'config_files': ('talos/mac_config.py',), 04:06:01 INFO - 'default_actions': ('clobber', 04:06:01 INFO - 'read-buildbot-config', 04:06:01 INFO - 'download-and-extract', 04:06:01 INFO - 'populate-webroot', 04:06:01 INFO - 'create-virtualenv', 04:06:01 INFO - 'install', 04:06:01 INFO - 'run-tests'), 04:06:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:01 INFO - 'download_minidump_stackwalk': True, 04:06:01 INFO - 'download_symbols': 'ondemand', 04:06:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:01 INFO - 'installer_path': 'installer.exe', 04:06:01 INFO - 'log_level': 'info', 04:06:01 INFO - 'log_name': 'talos', 04:06:01 INFO - 'log_to_console': True, 04:06:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:06:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:06:01 INFO - 'opt_config_files': (), 04:06:01 INFO - 'pip_index': False, 04:06:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:01 INFO - 'cmd': ('bash', 04:06:01 INFO - '-c', 04:06:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:01 INFO - 'enabled': True, 04:06:01 INFO - 'halt_on_failure': False, 04:06:01 INFO - 'name': 'check_screen_resolution'},), 04:06:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:06:01 INFO - 'cmd': ('bash', 04:06:01 INFO - '-c', 04:06:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:06:01 INFO - 'enabled': True, 04:06:01 INFO - 'halt_on_failure': False, 04:06:01 INFO - 'name': 'check_screen_resolution'},), 04:06:01 INFO - 'run_cmd_checks_enabled': True, 04:06:01 INFO - 'sps_profile': False, 04:06:01 INFO - 'sps_profile_interval': 0, 04:06:01 INFO - 'suite': 'dromaeojs', 04:06:01 INFO - 'system_bits': '32', 04:06:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:01 INFO - 'title': 't-yosemite-r7-0144', 04:06:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:01 INFO - 'use_talos_json': True, 04:06:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:01 INFO - 'work_dir': 'build'} 04:06:01 INFO - ##### 04:06:01 INFO - ##### Running clobber step. 04:06:01 INFO - ##### 04:06:01 INFO - Running pre-action listener: _resource_record_pre_action 04:06:01 INFO - Running main action method: clobber 04:06:01 INFO - rmtree: /builds/slave/test/build 04:06:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:02 INFO - Running post-action listener: _resource_record_post_action 04:06:02 INFO - ##### 04:06:02 INFO - ##### Running read-buildbot-config step. 04:06:02 INFO - ##### 04:06:02 INFO - Running pre-action listener: _resource_record_pre_action 04:06:02 INFO - Running main action method: read_buildbot_config 04:06:02 INFO - Using buildbot properties: 04:06:02 INFO - { 04:06:02 INFO - "project": "", 04:06:02 INFO - "product": "firefox", 04:06:02 INFO - "script_repo_revision": "production", 04:06:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:06:02 INFO - "repository": "", 04:06:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:06:02 INFO - "buildid": "20160324031044", 04:06:02 INFO - "pgo_build": "False", 04:06:02 INFO - "basedir": "/builds/slave/test", 04:06:02 INFO - "buildnumber": 550, 04:06:02 INFO - "slavename": "t-yosemite-r7-0144", 04:06:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:06:02 INFO - "platform": "yosemite_r7", 04:06:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:06:02 INFO - "branch": "fx-team", 04:06:02 INFO - "repo_path": "integration/fx-team", 04:06:02 INFO - "revision": "faa774eaf02c4128d0a80ad4d465c368c0cf023f", 04:06:02 INFO - "stage_platform": "macosx64", 04:06:02 INFO - "builduid": "6de99a595a5c4c43b21cdaa6dac173b1", 04:06:02 INFO - "slavebuilddir": "test" 04:06:02 INFO - } 04:06:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:06:02 INFO - Running post-action listener: _resource_record_post_action 04:06:02 INFO - ##### 04:06:02 INFO - ##### Running download-and-extract step. 04:06:02 INFO - ##### 04:06:02 INFO - Running pre-action listener: _resource_record_pre_action 04:06:02 INFO - Running main action method: download_and_extract 04:06:02 INFO - mkdir: /builds/slave/test/build/tests 04:06:02 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')]} 04:06:02 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:06:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:06:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:06:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:08 INFO - Downloaded 1199 bytes. 04:06:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:06:08 INFO - Using the following test package requirements: 04:06:08 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:06:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:06:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:06:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'jsshell-mac.zip'], 04:06:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:06:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:06:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:06:08 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:06:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:06:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:06:08 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:06:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:08 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:06:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:06:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:19 INFO - Downloaded 17921966 bytes. 04:06:19 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'] 04:06:19 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 04:06:22 INFO - Return code: 0 04:06:22 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 04:06: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')]} 04:06:22 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:23 INFO - Downloaded 17921966 bytes. 04:06:23 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'] 04:06:23 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 04:06:27 INFO - Return code: 0 04:06:27 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')]} 04:06:27 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:29 INFO - Downloaded 10847187 bytes. 04:06:29 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'] 04:06:29 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 04:06:29 INFO - Return code: 0 04:06: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')]} 04:06:29 INFO - https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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 04:06:37 INFO - Downloaded 111285803 bytes. 04:06:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:06:37 INFO - mkdir: /builds/slave/test/properties 04:06:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:37 INFO - Contents: 04:06:37 INFO - build_url:https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:06:38 INFO - Running post-action listener: _resource_record_post_action 04:06:38 INFO - Running post-action listener: set_extra_try_arguments 04:06:38 INFO - ##### 04:06:38 INFO - ##### Running populate-webroot step. 04:06:38 INFO - ##### 04:06:38 INFO - Running pre-action listener: _resource_record_pre_action 04:06:38 INFO - Running main action method: populate_webroot 04:06:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:38 INFO - '--tppagecycles', 04:06:38 INFO - '7'], 04:06:38 INFO - 'tests': ['tsvgm']}}, 04:06:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:06:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:06:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'tests': ['damp', 'tps']}, 04:06:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['damp', 'tps']}, 04:06:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:06:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:38 INFO - 'other': {'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'other_l64': {'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:06:38 INFO - 'ts_paint', 04:06:38 INFO - 'tpaint', 04:06:38 INFO - 'sessionrestore', 04:06:38 INFO - 'sessionrestore_no_auto_restore', 04:06:38 INFO - 'tabpaint']}, 04:06:38 INFO - 'svgr': {'tests': ['tsvgx', 04:06:38 INFO - 'tsvgr_opacity', 04:06:38 INFO - 'tart', 04:06:38 INFO - 'tscrollx', 04:06:38 INFO - 'cart']}, 04:06:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['tsvgx', 04:06:38 INFO - 'tsvgr_opacity', 04:06:38 INFO - 'tart', 04:06:38 INFO - 'tscrollx', 04:06:38 INFO - 'cart']}, 04:06:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'tests': ['tp5o']}, 04:06:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'talos_options': ['--e10s'], 04:06:38 INFO - 'tests': ['tp5o']}, 04:06:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'talos_options': ['--xperf_path', 04:06:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:38 INFO - 'tests': ['tp5n']}, 04:06:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:38 INFO - 'talos_options': ['--e10s', 04:06:38 INFO - '--xperf_path', 04:06:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:38 INFO - 'tests': ['tp5n']}}, 04:06:38 INFO - 'talos.zip': {'path': '', 04:06:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:38 INFO - Running post-action listener: _resource_record_post_action 04:06:38 INFO - ##### 04:06:38 INFO - ##### Running create-virtualenv step. 04:06:38 INFO - ##### 04:06:38 INFO - Running pre-action listener: _resource_record_pre_action 04:06:38 INFO - Running main action method: create_virtualenv 04:06:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:38 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 04:06:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:38 INFO - Using real prefix '/tools/python27' 04:06:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:42 INFO - Installing pip.................done. 04:06:42 INFO - Return code: 0 04:06:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:42 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 04:06:42 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 04:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:42 INFO - 'HOME': '/Users/cltbld', 04:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PAGER': '/bin/cat', 04:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:06:42 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - 'XPC_FLAGS': '0x0', 04:06:42 INFO - 'XPC_SERVICE_NAME': '0', 04:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:42 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 04:06:42 INFO - Cleaning up... 04:06:42 INFO - Return code: 0 04:06:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:42 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 04:06:42 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 04:06:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:06:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:42 INFO - 'HOME': '/Users/cltbld', 04:06:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PAGER': '/bin/cat', 04:06:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:06:42 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:06:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - 'XPC_FLAGS': '0x0', 04:06:42 INFO - 'XPC_SERVICE_NAME': '0', 04:06:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:43 INFO - Downloading/unpacking psutil>=0.7.1 04:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:47 INFO - Installing collected packages: psutil 04:06:47 INFO - Running setup.py install for psutil 04:06:47 INFO - building 'psutil._psutil_osx' extension 04:06:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:06:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:06:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:06:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:06:48 INFO - building 'psutil._psutil_posix' extension 04:06:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:06:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:06:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:06:48 INFO - ^ 04:06:48 INFO - 1 warning generated. 04:06:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:48 INFO - Successfully installed psutil 04:06:48 INFO - Cleaning up... 04:06:48 INFO - Return code: 0 04:06:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:48 INFO - 'HOME': '/Users/cltbld', 04:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:48 INFO - 'LOGNAME': 'cltbld', 04:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:48 INFO - 'MOZ_NO_REMOTE': '1', 04:06:48 INFO - 'NO_EM_RESTART': '1', 04:06:48 INFO - 'PAGER': '/bin/cat', 04:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:48 INFO - 'PWD': '/builds/slave/test', 04:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:48 INFO - 'SHELL': '/bin/bash', 04:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:06:48 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:48 INFO - 'USER': 'cltbld', 04:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:48 INFO - 'XPC_FLAGS': '0x0', 04:06:48 INFO - 'XPC_SERVICE_NAME': '0', 04:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:51 INFO - Installing collected packages: mozsystemmonitor 04:06:51 INFO - Running setup.py install for mozsystemmonitor 04:06:51 INFO - Successfully installed mozsystemmonitor 04:06:51 INFO - Cleaning up... 04:06:51 INFO - Return code: 0 04:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:06:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:51 INFO - 'HOME': '/Users/cltbld', 04:06:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:51 INFO - 'LOGNAME': 'cltbld', 04:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:51 INFO - 'MOZ_NO_REMOTE': '1', 04:06:51 INFO - 'NO_EM_RESTART': '1', 04:06:51 INFO - 'PAGER': '/bin/cat', 04:06:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:51 INFO - 'PWD': '/builds/slave/test', 04:06:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:51 INFO - 'SHELL': '/bin/bash', 04:06:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:06:51 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:06:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:51 INFO - 'USER': 'cltbld', 04:06:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:51 INFO - 'XPC_FLAGS': '0x0', 04:06:51 INFO - 'XPC_SERVICE_NAME': '0', 04:06:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:56 INFO - Downloading docopt-0.6.1.tar.gz 04:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:56 INFO - Running setup.py install for blobuploader 04:06:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:56 INFO - Running setup.py install for requests 04:06:57 INFO - Running setup.py install for docopt 04:06:57 INFO - Successfully installed blobuploader requests docopt 04:06:57 INFO - Cleaning up... 04:06:57 INFO - Return code: 0 04:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:57 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')]} 04:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:57 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')]} 04:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:57 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:06:57 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 04:06:57 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 04:06:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:06:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:57 INFO - 'HOME': '/Users/cltbld', 04:06:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:57 INFO - 'LOGNAME': 'cltbld', 04:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:57 INFO - 'MOZ_NO_REMOTE': '1', 04:06:57 INFO - 'NO_EM_RESTART': '1', 04:06:57 INFO - 'PAGER': '/bin/cat', 04:06:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:57 INFO - 'PWD': '/builds/slave/test', 04:06:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:57 INFO - 'SHELL': '/bin/bash', 04:06:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:06:57 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:06:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:57 INFO - 'USER': 'cltbld', 04:06:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:57 INFO - 'XPC_FLAGS': '0x0', 04:06:57 INFO - 'XPC_SERVICE_NAME': '0', 04:06:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:57 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-pXj7xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:57 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-m00iwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:57 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-BH8z3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:57 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3nJkOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:57 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-2fACDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-voDgpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Tew4xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-4audWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vP9tO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-l0Gotn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-iTrhPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-YWwb7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-h47Y1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VLqbq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-O9AwVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-5XIjoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-YxKQUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:59 INFO - Running setup.py install for manifestparser 04:06:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:59 INFO - Running setup.py install for mozcrash 04:06:59 INFO - Running setup.py install for mozdebug 04:06:59 INFO - Running setup.py install for mozdevice 04:06:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:59 INFO - Running setup.py install for mozfile 04:07:00 INFO - Running setup.py install for mozhttpd 04:07:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Running setup.py install for mozinfo 04:07:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Running setup.py install for mozInstall 04:07:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Running setup.py install for mozleak 04:07:00 INFO - Running setup.py install for mozlog 04:07:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Running setup.py install for moznetwork 04:07:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:07:00 INFO - Running setup.py install for mozprocess 04:07:01 INFO - Running setup.py install for mozprofile 04:07:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:07:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:07:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:07:01 INFO - Running setup.py install for mozrunner 04:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:07:01 INFO - Running setup.py install for mozscreenshot 04:07:01 INFO - Running setup.py install for moztest 04:07:01 INFO - Running setup.py install for mozversion 04:07:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:07:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:07:01 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:01 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')]} 04:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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')]} 04:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:07:01 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 04:07:01 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 04:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:01 INFO - 'HOME': '/Users/cltbld', 04:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PAGER': '/bin/cat', 04:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:07:01 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - 'XPC_FLAGS': '0x0', 04:07:01 INFO - 'XPC_SERVICE_NAME': '0', 04:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-gjyW8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VeSK50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-BgRMlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-4aQBnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-fldue_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lQnWP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-OZJPrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:07:02 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)) 04:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:07:02 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Ck0JEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-H9DvrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-IVuF_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-6OsNep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-lSRKo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-iREz32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-H78a6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-4LtXik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-1byuEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:07:03 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)) 04:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:07:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-npyAdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:07:03 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)) 04:07:03 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)) 04:07:03 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)) 04:07:03 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)) 04:07:03 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)) 04:07:03 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)) 04:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:03 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 04:07:08 INFO - Downloading blessings-1.6.tar.gz 04:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:08 INFO - Installing collected packages: blessings 04:07:08 INFO - Running setup.py install for blessings 04:07:08 INFO - Successfully installed blessings 04:07:08 INFO - Cleaning up... 04:07:08 INFO - Return code: 0 04:07:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:08 INFO - Reading from file tmpfile_stdout 04:07:08 INFO - Current package versions: 04:07:08 INFO - blessings == 1.6 04:07:08 INFO - blobuploader == 1.2.4 04:07:08 INFO - docopt == 0.6.1 04:07:08 INFO - manifestparser == 1.1 04:07:08 INFO - mozInstall == 1.12 04:07:08 INFO - mozcrash == 0.17 04:07:08 INFO - mozdebug == 0.1 04:07:08 INFO - mozdevice == 0.48 04:07:08 INFO - mozfile == 1.2 04:07:08 INFO - mozhttpd == 0.7 04:07:08 INFO - mozinfo == 0.9 04:07:08 INFO - mozleak == 0.1 04:07:08 INFO - mozlog == 3.1 04:07:08 INFO - moznetwork == 0.27 04:07:08 INFO - mozprocess == 0.22 04:07:08 INFO - mozprofile == 0.28 04:07:08 INFO - mozrunner == 6.11 04:07:08 INFO - mozscreenshot == 0.1 04:07:08 INFO - mozsystemmonitor == 0.0 04:07:08 INFO - moztest == 0.7 04:07:08 INFO - mozversion == 1.4 04:07:08 INFO - psutil == 3.1.1 04:07:08 INFO - requests == 1.2.3 04:07:08 INFO - wsgiref == 0.1.2 04:07:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:08 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:07:08 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 04:07:08 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 04:07:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:07:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:08 INFO - 'HOME': '/Users/cltbld', 04:07:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:08 INFO - 'LOGNAME': 'cltbld', 04:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:08 INFO - 'MOZ_NO_REMOTE': '1', 04:07:08 INFO - 'NO_EM_RESTART': '1', 04:07:08 INFO - 'PAGER': '/bin/cat', 04:07:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:08 INFO - 'PWD': '/builds/slave/test', 04:07:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:08 INFO - 'SHELL': '/bin/bash', 04:07:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:07:08 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:07:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:08 INFO - 'USER': 'cltbld', 04:07:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:08 INFO - 'XPC_FLAGS': '0x0', 04:07:08 INFO - 'XPC_SERVICE_NAME': '0', 04:07:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 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)) 04:07:09 INFO - Cleaning up... 04:07:09 INFO - Return code: 0 04:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:07:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:07:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:09 INFO - 'HOME': '/Users/cltbld', 04:07:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:09 INFO - 'LOGNAME': 'cltbld', 04:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:09 INFO - 'MOZ_NO_REMOTE': '1', 04:07:09 INFO - 'NO_EM_RESTART': '1', 04:07:09 INFO - 'PAGER': '/bin/cat', 04:07:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:09 INFO - 'PWD': '/builds/slave/test', 04:07:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:09 INFO - 'SHELL': '/bin/bash', 04:07:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:07:09 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:07:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:09 INFO - 'USER': 'cltbld', 04:07:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:09 INFO - 'XPC_FLAGS': '0x0', 04:07:09 INFO - 'XPC_SERVICE_NAME': '0', 04:07:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:09 INFO - Downloading/unpacking jsonschema 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:07:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:07:13 INFO - warning: no files found matching '*.txt' 04:07:13 INFO - no previously-included directories found matching 'build' 04:07:13 INFO - no previously-included directories found matching 'dist' 04:07:13 INFO - no previously-included directories found matching '.git*' 04:07:13 INFO - Installing collected packages: jsonschema, functools32 04:07:13 INFO - Running setup.py install for functools32 04:07:13 INFO - warning: no files found matching '*.txt' 04:07:13 INFO - no previously-included directories found matching 'build' 04:07:13 INFO - no previously-included directories found matching 'dist' 04:07:13 INFO - no previously-included directories found matching '.git*' 04:07:13 INFO - Successfully installed jsonschema functools32 04:07:13 INFO - Cleaning up... 04:07:13 INFO - Return code: 0 04:07:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:13 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')]} 04:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:13 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')]} 04:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:13 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 0x110545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110555420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff141c9a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, '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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 04:07:13 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 04:07:13 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 04:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:13 INFO - 'HOME': '/Users/cltbld', 04:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:13 INFO - 'LOGNAME': 'cltbld', 04:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:13 INFO - 'MOZ_NO_REMOTE': '1', 04:07:13 INFO - 'NO_EM_RESTART': '1', 04:07:13 INFO - 'PAGER': '/bin/cat', 04:07:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:13 INFO - 'PWD': '/builds/slave/test', 04:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:13 INFO - 'SHELL': '/bin/bash', 04:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:07:13 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:13 INFO - 'USER': 'cltbld', 04:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:13 INFO - 'XPC_FLAGS': '0x0', 04:07:13 INFO - 'XPC_SERVICE_NAME': '0', 04:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:14 INFO - Downloading/unpacking flake8 04:07:14 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 04:07:14 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 04:07:14 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 04:07:14 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 04:07:14 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 04:07:14 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 04:07:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:16 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 04:07:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:17 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 04:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:18 INFO - no previously-included directories found matching 'docs/_build' 04:07:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:18 INFO - Running setup.py install for pep8 04:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:18 INFO - no previously-included directories found matching 'docs/_build' 04:07:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:18 INFO - Cleaning up... 04:07:18 INFO - Return code: 0 04:07:18 INFO - Running post-action listener: _resource_record_post_action 04:07:18 INFO - Running post-action listener: _start_resource_monitoring 04:07:18 INFO - Starting resource monitoring. 04:07:18 INFO - ##### 04:07:18 INFO - ##### Running install step. 04:07:18 INFO - ##### 04:07:18 INFO - Running pre-action listener: _resource_record_pre_action 04:07:18 INFO - Running main action method: install 04:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:18 INFO - Reading from file tmpfile_stdout 04:07:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:18 INFO - Reading from file tmpfile_stdout 04:07:18 INFO - Output received: 04:07:18 INFO - Usage: mozinstall [options] installer 04:07:18 INFO - Options: 04:07:18 INFO - -h, --help show this help message and exit 04:07:18 INFO - -d DEST, --destination=DEST 04:07:18 INFO - Directory to install application into. [default: 04:07:18 INFO - "/builds/slave/test"] 04:07:18 INFO - --app=APP Application being installed. [default: firefox] 04:07:18 INFO - mkdir: /builds/slave/test/build/application 04:07:18 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'] 04:07:18 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 04:07:52 INFO - Reading from file tmpfile_stdout 04:07:52 INFO - Output received: 04:07:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:07:52 INFO - Running post-action listener: _resource_record_post_action 04:07:52 INFO - ##### 04:07:52 INFO - ##### Running run-tests step. 04:07:52 INFO - ##### 04:07:52 INFO - Running pre-action listener: _resource_record_pre_action 04:07:52 INFO - Running main action method: run_tests 04:07:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:52 INFO - 2016-03-24 04:07:52.632 screenresolution[1644:7938] starting screenresolution argv=screenresolution get 04:07:52 INFO - 2016-03-24 04:07:52.634 screenresolution[1644:7938] Display 0: 1600x1200x32@60 04:07:52 INFO - 2016-03-24 04:07:52.640 screenresolution[1645:7940] starting screenresolution argv=screenresolution list 04:07:52 INFO - Available Modes on Display 0 04:07:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:52 INFO - Intel Iris: 04:07:52 INFO - Chipset Model: Intel Iris 04:07:52 INFO - Type: GPU 04:07:52 INFO - Bus: Built-In 04:07:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:52 INFO - Vendor: Intel (0x8086) 04:07:52 INFO - Device ID: 0x0a2e 04:07:52 INFO - Revision ID: 0x0009 04:07:52 INFO - Displays: 04:07:52 INFO - Display: 04:07:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:52 INFO - Display Serial Number: 1600x1200 60 04:07:52 INFO - Main Display: Yes 04:07:52 INFO - Mirror: Off 04:07:52 INFO - Online: Yes 04:07:52 INFO - Rotation: Supported 04:07:52 INFO - Return code: 0 04:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:52 INFO - Python 2.7.3 04:07:52 INFO - Return code: 0 04:07:52 INFO - grabbing minidump binary from tooltool 04:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:52 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 0x1103e4e00>, '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 0x11020ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103dfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:52 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 04:07:52 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 04:07:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:52 INFO - Return code: 0 04:07:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:54 INFO - Return code: 0 04:07:54 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 04:07:54 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 04:07:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D5u9Mm4uFG/Render', 04:07:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:54 INFO - 'HOME': '/Users/cltbld', 04:07:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:54 INFO - 'LOGNAME': 'cltbld', 04:07:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:54 INFO - 'MOZ_NO_REMOTE': '1', 04:07:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:54 INFO - 'NO_EM_RESTART': '1', 04:07:54 INFO - 'PAGER': '/bin/cat', 04:07:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:54 INFO - 'PWD': '/builds/slave/test', 04:07:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:54 INFO - 'SHELL': '/bin/bash', 04:07:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7ldxzIFJth/Listeners', 04:07:54 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 04:07:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:54 INFO - 'USER': 'cltbld', 04:07:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:54 INFO - 'XPC_FLAGS': '0x0', 04:07:54 INFO - 'XPC_SERVICE_NAME': '0', 04:07:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:54 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/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 04:07:54 INFO - mozversion application_buildid: 20160324031044 04:07:54 INFO - mozversion application_changeset: faa774eaf02c4128d0a80ad4d465c368c0cf023f 04:07:54 INFO - mozversion application_display_name: Nightly 04:07:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:54 INFO - mozversion application_name: Firefox 04:07:54 INFO - mozversion application_remotingname: firefox 04:07:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:07:54 INFO - mozversion application_vendor: Mozilla 04:07:54 INFO - mozversion application_version: 48.0a1 04:07:54 INFO - mozversion platform_buildid: 20160324031044 04:07:54 INFO - mozversion platform_changeset: faa774eaf02c4128d0a80ad4d465c368c0cf023f 04:07:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:07:54 INFO - mozversion platform_version: 48.0a1 04:07:54 INFO - using testdate: 1458817674 04:07:54 INFO - actual date: 1458817674 04:07:54 INFO - starting webserver on 'localhost:49278' 04:07:54 INFO - SUITE-START | Running 2 tests 04:07:54 INFO - TEST-START | dromaeo_css 04:07:54 INFO - operating with platform_type : mac_ 04:07:54 INFO - Initialising browser for dromaeo_css test... 04:07:54 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpx8DYZi/profile http://localhost:49278/getInfo.html) 04:07:56 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 04:07:56 INFO - PROCESS | 1663 | colorDepth:24 04:07:56 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 04:07:56 INFO - PROCESS | 1663 | __metrics 04:07:56 INFO - PROCESS | 1663 | 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" 04:07:56 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:07:57 INFO - TEST-INFO | 1663: exit 0 04:07:57 INFO - Browser initialized. 04:07:57 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:57 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpx8DYZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:09 INFO - PROCESS | 1667 | RSS: Main: 247107584 04:08:09 INFO - PROCESS | 1667 | 04:09:00 INFO - PROCESS | 1667 | 1458817740446 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] 04:11:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:11:12 INFO - PROCESS | 1667 | RSS: Main: 370188288 04:11:12 INFO - PROCESS | 1667 | 04:14:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:14:15 INFO - PROCESS | 1667 | RSS: Main: 376078336 04:14:15 INFO - PROCESS | 1667 | 04:17:17 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:17:17 INFO - PROCESS | 1667 | RSS: Main: 377901056 04:17:17 INFO - PROCESS | 1667 | 04:20:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:20:20 INFO - PROCESS | 1667 | RSS: Main: 338771968 04:20:20 INFO - PROCESS | 1667 | 04:23:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 04:23:24 INFO - PROCESS | 1667 | RSS: Main: 338558976 04:23:24 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 04:26:27 INFO - PROCESS | 1667 | RSS: Main: 405770240 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | __start_tp_report 04:26:27 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 04:26:27 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 04:26:27 INFO - PROCESS | 1667 | |i|pagename|runs| 04:26:27 INFO - PROCESS | 1667 | |0;dojo.html;3455.429854074078;3498.9650103498957;3500.191743571611;3545.804980726059;3575.6960658344037;5607.775688972436;5668.57485688574;5673.914891276634;5706.0585003474425;5760.366359700435;5690.118031705092;5695.288088988877;5739.885202295952;5836.503897168735;5862.76548938043;5117.641765076446;5131.409887862887;5170.121079416508;5184.559312458446;5299.920501192485;5243.370795504526;5262.736863156846;5278.630495865291;5305.495977882095;5345.118055520835;5087.923681144785;5098.541131298182;5205.115130427817;5211.661242019257;5224.686518808883;5182.97408512955;5189.481051894818;5208.088584497697;5220.582353411718;5221.791128354861;5143.202803565453;5173.922391164136;5188.610854185951;5202.661826981234;5219.0083884061905;5477.4796394342475;5519.172124181365;5588.21764952907;5667.263255776764;5676.403977582336;6202.00767877142;6202.41077097675;6203.038529028008;6210.099535567318;6212.751489940397;5234.528892399664;6162.22972128484;6210.1616281801835;6221.813345599639;6222.377762223787;5658.971705141448;5662.773489060474;5757.769689212427;5759.65442073477;5761.596688231867;6197.4732147767945;6232.594881332699;6235.501159907197;6240.500759939194;6244.188255526752;6068.096643010931;6114.724837382329;6117.188044311343;6147.323794382614;6158;6226.813195604049;6232.439080482688;6232.906506402408;6242.438180563771;6245.718942647592;6060.212172417558;6110.953680641517;6177.073438984098;6201.596896201822;6222.3466536013975;6129.233845769279;6134.681512609229;6141.424638644238;6145.262568491809;6148.600340977822;4809.134355815917;4867.683600565952;4888.364512613338;4929.285253638202;4970.826021089245;4246.915061698749;4298.312270036779;4348.956510434855;4385.583369579948;4430.8449204277695;5563.304586926634;5660.5471562274915;5694.943050569441;5709.262652900135;5754.9424505754405;6156.661383623854;6160.383961603893;6241.095041218998;6252.624842509464;6259.280182778948;5685.715714214272;5700.714964251771;5703.657780533182;5709.200711900337;5721.5708821838525;5215.921761173586;5310.415854256029;5333.359996800331;5337.519623233928;5344.064788661969;6216.347283535164;6226.59527130735;6243.968780156161;6250.812475625738;6287.874242515216;6110.4980065817745;6203.348648391854;6214.533909956862;6219.502439804714;6236.469900058364;6283.2774230962195;6287.528435367457;6299.716512757029;6310.242770867341;6310.905336420049;6050.969745151246;6127.220070483952;6135;6154.076888466766;6179.62922224668;6141.823559979257;6147.385261473817;6189.164462797465;6192.411720886689;6239.188905442264;5874.295084589877;6018.8194354169445;6047.606905551125;6051.7579296827635;6100.572959892942;5941.732622031933;5995.130706047686;6047.425494578008;6064.787732429344;6088.360722124113;4867.975660121819;5842.795502157574;5891.440313170413;5911.261092363455;5932.16949627044;6048.304444988707;6059.575829691879;6073.969630151821;6135.263768347827;6139.140520327069;5731.340895797037;5843.766249350148;5924.407559244041;5937.2578427696535;5946 04:26:27 INFO - PROCESS | 1667 | |1;ext.html;445.3898159521456;548.4241546376305;583.6837930466796;598.5858528183021;641.1184621145923;30335;39412.80293598532;39595.20809583814;39703.20593588126;39937;41360.58639413605;42037.15925681492;42117.36823947635;42141.36787948183;42162.578374216246;8308.501489910594;8946.41848279863;9078.591463384131;9515.714528564155;9776.560054797515;9582.472963986978;9701.126898579127;9749.220062395027;9775.364601300927;9867;9806.313558050939;9896.208303335716;9901.801963960717;9912.256580756437;9924.751881202992;9815.362001469917;9882.357646752938;9883.258755593288;9890.20878329732;9896.950515247414;9775.120239178437;9920.95039524805;9936.602535898555;9944.850827237597;9950.054744799232;40945.59054409448;41299.58700412988;41474;41487.37768933469;41497.79251103755;3183.331500384899;3227.3222623249144;3253.8535765890592;3397.3286730745226;3711.2577484502935;27045.729542704517;27504.44991100187;28829.56755648667;28839.423211535654;28913;2599.7400259974042;2635.19489149931;2657.7740892024203;2660.720624334456;2674.2645772412548;396633;398021.0098949487;399309;400079;400851;65701.67149164224;66203;66693.66612667816;66728.33271667222;66728.6663566679;70307.2969270311;70449.64775176092;70476.94284585633;70567.64716176386;70806.29193707996;16759.748603770953;16959.576010599834;17373.47879563615;17397.217125229396;17413.91293043527;13119.606411807661;13199.67000824987;13226.73546529064;13227.140235884637;13233;20953.68569471459;22016.669749953762;22024.008919598655;22037.669434958487;22045.89770511468;8000.479968802009;9215;9393.436393816393;9490.430574165572;9503.144716975366;736.3934140688926;1018.2821111116644;1026.9794604108026;1042.6298663974333;1089.3844977587637;27899.721002789713;27966;28318.43363132767;28512.572311415344;28633;1072.570971611346;1100.4772732951783;1119.8544189255344;1121.377635412354;1189.9405029748477;14409.567712968628;14493.855061449462;14777.704445911022;14879.735222506208;15149;533903;539421;539594;539926;542929;59721.40278597245;60369;60432;60445;60558.39441605616;1271.6820794801115;1345.2466618693563;1454.5854431487187;1465.8607432293916;1497.5956491747168;27826.469544175266;27942.720572794013;29351.55972660369;29701.257468563457;29851.338942247687;48409;48679.756601216766;49157.99999999857;49243.753781230866;49253.01493970172;367951;369926;370286;370605;370799;28076.29809254785;32646.51030234596;33170.673173072806;33608.66391336153;33937;35721;39113;40551.3917291235;42255.788721057426;42560.78719606382;36028.639713603574;38453;38521.22957540777;39136.02159946024;39568.80215598903;36470.45914753934;37070;37481.87554373264;38145.61854381532;38282;35830.82084589561;35954.8202258987;36248.63751362558;37027;37218.62781372152;32289.70841166421;32733.836330818194;32991.50512742359;33195.17012074718;33308.833455832566;24385;24509;24782.628260576468;25044.499110018063;25100 04:26:27 INFO - PROCESS | 1667 | |2;jquery.html;354.6666133834196;363.75446573562846;365.8481730082016;366.74327970420694;368.4933216826863;19725.81645101293;19741.605167896632;21013.47466313343;21033.68449473255;21035.894820525875;12079.094067944896;12391.25652460853;12403.813942790865;12403.93798031011;12412;5048.394192696873;5285.445028272034;5299.735013249322;5964.105384192362;5966.254218222723;5868.207791948096;5875.500582450497;5918.674472903988;5920.585559010871;5930.733117009745;5844.006518891777;5901.026330655437;6199.659018753967;6385.297617262097;6387.393197646239;6337.98592225244;6356.364363563653;6360.872782544347;6373.107764912916;6382.744690212409;5318.521333080042;5520.944790552083;5555.416681248492;5651.943480565183;5657.9434205658235;24683.765811709523;24998.625020624706;25157.49685006308;25184.622230666555;25592;1871.1392759330724;2027.4019164346553;2080.053575623088;2377.3699969508093;2404.5671779079757;9299.535023248878;10013.59945602175;10048.346857454242;10121.49392530378;10184.694459166238;1667.5330907345963;1713.837185467391;1726.6460375622967;1755.4821327708357;1775.6359946211126;102287.48856255745;104592;104757.47621261845;105168;105205;11243.494042768096;11282.266652667551;11341.26281791681;11345.546178152781;11463.025642820287;13537.796933046013;13581.11722738019;13588.59234222975;13617.387217575233;13620.863791362157;6824.351686589766;8009.199080091944;8175.71385001534;8179.591020448954;8270.338372930151;8021.679132834738;8081.111077781439;8087.069986951458;8187.38594605407;8206.097329293772;4452.30989196675;4475.261581839025;4481.395011673448;4488.371627972087;4529.773511324421;1441.373002743789;1783.0371599336472;1821.5264031351944;1884.8209420105068;1889.56539995799;858.274757829633;882.3558802074522;957.3968399908152;1031.515187861704;1063.8404239364002;16141.112238826743;19184.520386990156;20196.29312974039;20517.38447846567;20877.164913403292;961.2262128986233;989.5893204320126;1004.161525126513;1044.4307852220559;1066.36018388966;10602.992715691997;10883.983369629808;10990.780184396268;11053.28153670009;11140.721481963015;575063.1246843738;582625;600650;601360;615750;82827;109913.45043274733;112833.43583282195;113274;114166;1007.8185926533148;1027.5992362978445;1050.5377633840933;1055.0293729768478;1056.2131212246925;17052.829471705125;17822.91088544549;17874.016929069025;18108.637827243117;18299.54251143732;31801.204969875937;40974.79512602418;48126.75936620295;49332.26001609907;51058.74470627623;74064.74017115218;74382;75201;75643;75791.62104189444;7538.208488108669;7562.962185189039;7604.96197519031;7730.845383092419;7848.136704962564;8952.731418057469;11560.190786644855;12062.215955962834;12362.629121126382;12506.687332816753;9750.80498390014;10391.792164156826;10722.463876805972;10745.301555398873;10839.295445795999;7866.6066696666085;10612.363258204532;10637.574497020032;10664.786704266027;10812.135029197803;10647.201459890694;10798.514066867167;11094;11212.887871121184;11231.775364492501;7670.156282808998;7799.142094369501;7930.9603451982375;7937.126916039347;8191.385646076449;9450.763730906783;10727.946360268148;10766.461676915966;11066.889331106586;11090.390028548507 04:26:27 INFO - PROCESS | 1667 | |3;mootools.html;1399.9370028348724;1617.9676406471872;1641.5813967438305;1649.5381293237897;2032.6036422897541;7899.052113746351;8628.266597339225;8782.341324400664;8796.69211577595;8801.691940782066;8413.915860841389;8674;8691.000534938485;8691.652333906652;8693.826123477527;2166.480044789255;2311.757265487129;2344.6248600223967;2435.257246539805;2485.3662316109458;2504.3238325652064;2515.5220508103494;2518.659980902582;2520.4959008198343;2521.281434791085;2418.576749068906;2440.8291419600546;2447.840890342122;2459.139301244559;2459.7048354197523;2417.093589903786;2449.1183174057323;2454.460018795871;2476.418041760185;2482.5407299649623;2460.815438842094;2495.4510007798253;2500.199936020474;2502.311864237331;2512.8617926014063;8852.51311177885;8939.64241430342;8949.507777072258;8951.641934322619;8952.060033696433;5339.919901201485;5467.20725494801;5497.367802702701;5504.862378440531;5511.283533140706;3553.5202747629255;3634.9818250908575;3707.277080969212;3710.610385909468;3720.813959302051;928.0302084321833;931.5528546297747;1000.9640022576598;1019.6125472320545;1061.1881910338598;11260.324380537195;11414.14393920451;11428.028617567517;11476.311421314664;11488.080953523699;4745;4758.976205118952;4792.400949881265;4821.855344339676;4851.466338702739;9299.256059515223;9299.67451139207;9309.487978161265;9309.581068851918;9318.440893546409;5423.457654234624;5424.810131645373;5426.348838139448;5446.618736688394;5487.890242195133;4373.387725718402;4509.526499717548;4672.556107169813;4755.548222918817;4757.571818536279;3753.3806921858136;3814.4659747635355;3828.693704503633;3853.460515527828;3862.362710152793;1035.6478797208986;1185.3125187391292;1193.7254431480808;1207.076586411396;1208.528673817212;1093.2128867215592;1114.8216285394299;1130.1298000539539;1324.8145259663654;1423.252792284059;8201.753947381589;8238.011438627404;8279.047909490366;8285.171482851667;8303.252707256375;515.7343967856557;525.8448757616512;527.9498447647468;528.3184691747603;530.7372850439058;5178.97410512945;5415.53967912724;6318.905216421757;6340.175777149033;6371.33101024395;10362.222833287533;10577.048065674126;10629.255952083435;10677.51951162184;10713.142948564097;10226.539805708611;10440.947795261127;10465.110465610509;10575.524101415454;10595.470226488645;8153.470024448392;8292.253697167283;8358.791030224293;8385.538795366192;8399.496030238206;8042.67829286822;8082.2725954664365;8092.878606820785;8131.146229645802;8187.71343002992;9248.722538323862;9334.206592439446;9401.10689484498;9443.150116489549;9474.810503790024;9782.510874456106;9886.060824221975;9995.250356223458;10175.7456063599;10227.59089636436;6953;7100.928990710234;7523.774286771406;7715.961420192863;7860.685572577033;8332.125126861592;8385.664573416994;8391.874121888055;8400.327973761961;8426.452280601741;7295.8540829184185;7357.558546487228;7416.66625001887;7499.1750907399055;7628.504147230412;7247.13034435871;7283.708651654087;7289.5261807982315;7365.815854603464;7391.189158655949;7705.383569314329;7734.265244801735;7737.226277372218;7741.845163096594;7749.92250077492;6923.238443771282;7014.263502332182;7035.296470352924;7064.32888875556;7076.398506127037;7103.431725461847;7182.748603798842;7248.456365772694;7297.817554560966;7304.306090921354 04:26:27 INFO - PROCESS | 1667 | |4;prototype.html;303.69478673932696;328.87831502344136;332.20934176659546;335.09190094842984;338.04165191681597;5593.916091258624;6449.677516124193;6555.049517819919;6559.180102487189;6570.835729106775;6489.383508566691;6516.96741516293;6519.967400163005;6544.70548825304;6545.639989800571;4652.092841895815;4736.218523943562;4743.573078422941;4860.927086093711;4878.268259761037;4852.708837469745;4862.97568512157;4872.878178045542;4873.147199240118;4883.19427294496;4271.145770845827;4546.727196368212;4809.182438985381;4835.903281934359;4838.322634831109;4625.236835922069;4696.4129483814695;4786.1863483207935;4814.9277760833265;4818.349522814446;4125.773082480462;4137.689673274516;4146.398772178048;4147.875563733093;4153.54311025787;6167.44492995628;6192.28788689302;6195.31851496335;6206.751729930797;6216.440520353145;5569.220309156722;5602.523785478198;5652.265205523256;5652.689102099383;5656.377798442168;6692.330766923317;6892.414144797698;6899.9650052492525;6906.033155358254;6910.961266426366;4176.979115104436;4397.2304846651705;4599.632029437637;4679.532046795327;4688.812447502096;5964.224650795456;7146.213916469184;7253.492255542114;7326.4505162113055;7328.487005909588;4751.809927602857;4763.857084287477;4764.76176191196;4767.094252092092;4776.21192503233;4798.5441383068555;4815.181419158752;4817.542333478314;4823.782929768169;4828.66199366048;4617.930731039037;5618.578606604521;5651.943480565224;5658;5673.149027645886;5773.6431938494425;6371.299157092716;6891.96620506928;6938.063361446241;6955.1653801544135;1674.2047527424377;1685.7639930409753;1693.09419460588;1696.151924037981;1700.3368686212386;1042.5985995391677;1071.2340676416243;1105.264998775805;1109.378747901178;1123.5168877382803;6413.262474815363;6435.195600549931;6444.420002199825;6467.482601391877;6474.061261117112;7128.643567821692;7134.393576546052;7140.7500737474975;7156.60638664868;7158.570485770871;6441.323661015525;6452.838679032968;6453.257875344301;6456.903146452807;6485.805425837232;3752.5496940366784;3810.066533699206;3812.370958791824;3814.1608846053823;3818.7326887118193;7185.89221161683;7518;7521.699132034657;7523.924760752432;7525.736599219001;7386.556806591621;7456.40348772097;7486.32623063916;7514.624268786539;7539.924600754032;6159.784407545714;7606.353459955966;7637.5035622685455;7639.312461878458;7640.885386719204;6990.566933778665;7280.599567023864;7281.19906810261;7295.161056478573;7304.671289791866;7163.820904477429;7223.097112860893;7227.313405226495;7232.783016509513;7243.45674074436;7625.389968802593;7634.312911837961;7636.427267954815;7643.273888980538;7649.885251721117;3815.389537673959;4574.085182963354;4620.745858977789;4632.166210082218;4648.83729069481;7006.684699188447;7278.854422911406;7287.817804554928;7289.817754556178;7293.52592081513;7001.474889383215;7026.9648651756415;7055.858882822212;7065.717371305091;7068.71725130989;6971.0937578116545;7035.803913334643;7040.683169257498;7045.577265364094;7051.189113251837;6848.842614576392;6850.38346548813;6850.486213533905;6859.108315918898;6859.794206173823;6697.464202863856;6730.6971186297715;7021.192562855133;7022.54353467023;7044.577325360495;6099.420555047263;6593.340665933369;6720.1599800025;6744.393004629607;6873.48448866347 04:26:27 INFO - PROCESS | 1667 | |5;yui.html;650.4438704907303;689.7827184436902;705.1925545250687;724.688383994882;761.2691815856778;15105.924470377646;15289.923550382246;15325.770113448307;15342.616434589141;16287.918560407212;16414.917925410387;16441.177941102927;16464.259108340124;16504.009759414443;16572.41996530122;749.5315427857589;759.4569882533987;927.3647551427293;930.371998900741;930.3766476460787;935.1163150822475;950.1068995144576;950.3442624589046;950.3490109275134;951.6478902805972;977.0180968127022;982.8230918434679;983.7343917142367;984.099548912744;984.4487087231138;792.5205250823255;975.5463709375139;978.5938835383307;984.7636567223886;996.6312464388222;745.608555508357;747.1333253426054;748.5172064018732;749.6476655971685;759.7454852624378;15359.846401535953;15393.923030384889;15417.537473875802;15420.537383878502;15445.227738613024;12204.816927746091;12274.570390036306;12313.630591082281;12535.498580056787;12563.246205227624;10089.142422893989;10146.340487868265;10207.489625518769;10541.104006159485;11041.447927603587;3081.1834863761123;3483.0943954571994;3522.559680039995;3634.036980200249;3635.1093981974323;80998;81498.59250703768;82343.5882820588;84241.15758842394;84482.57758711166;9342.766430839283;9375.812483750424;9410.527568897405;9429.905700942903;9755.00425841344;16956;20986;20990;20995.055222515024;21018.159273628884;5819;7455.962720186364;7529.284717951786;7540.3213710766295;7637.809054773564;3446.758726889144;4102.241085399151;4118.855840045584;4152.854650087293;4380.8685739427865;3578.6958108560543;3583.014670965453;3628.219932714479;3630.8366123524506;3631.4915911772373;657.3689258312074;679.3342524326089;680.3876511140014;686.7939618114546;688.8553403785261;478.27780052121545;554.3071161048689;581.6393835821817;589.1280904261716;599.9970000149972;7943.324817390471;8011.359091272684;8102.149274326229;8212.507249565046;8253.688134517772;586.6568057686301;590.173756740558;593.8604427959426;595.627732667083;614.6926536731634;3719.8698045568276;3804.771713697187;3815.7328986970647;3824.8470061197795;3852.3643598805884;95202;95383;96975;97593.51203243938;97597.02402975879;55053;76701;77160.84258736011;78040.60979695065;78271.60864195642;67832;68371.65814170898;68573.65713171502;70759;71985.28014719891;8263.834723305621;8440.53577053268;8444.957775211085;8450.66197352099;8473.745787626382;43500.91247718832;48279.75860120677;49431.75284123556;51194.74402627963;51983.74008129935;66109.66945165243;67267;69512;70238.59522809618;70674;10864.619738309122;11030.283031603241;11224.214304998572;11302.830457543309;11505.942470287595;12073.818892716792;12171.634850954486;12447.564335248222;12453.06602004835;12462.314572698226;11187.552497899993;11467.139964502863;11468.770624587294;11744.17790754639;11796.410179491162;10785.838212426663;10846.783064338826;10892.074173695324;10897.019268265576;11379.317240965569;11183.161262905152;11240.4379781009;11269.380184089627;11426.542938282708;11541.538338466367;9173.633054677739;9342.439453632804;9535.284853636143;9638.566264517973;9958.55186516594;9024.96382954394;9157.267418606629;9259.074092590687;9410.717678469384;9452.858207126761 04:26:27 INFO - PROCESS | 1667 | __end_tp_report 04:26:27 INFO - PROCESS | 1667 | __start_cc_report 04:26:27 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1169 04:26:27 INFO - PROCESS | 1667 | __end_cc_report 04:26:27 INFO - PROCESS | 1667 | __startTimestamp1458818787481__endTimestamp 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | ------- Summary: start ------- 04:26:27 INFO - PROCESS | 1667 | Number of tests: 6 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5705.56 Median:5911.26 stddev:618.33 (10.5%) stddev-sans-first:594.50 04:26:27 INFO - PROCESS | 1667 | Values: 3455.4 3499.0 3500.2 3545.8 3575.7 5607.8 5668.6 5673.9 5706.1 5760.4 5690.1 5695.3 5739.9 5836.5 5862.8 5117.6 5131.4 5170.1 5184.6 5299.9 5243.4 5262.7 5278.6 5305.5 5345.1 5087.9 5098.5 5205.1 5211.7 5224.7 5183.0 5189.5 5208.1 5220.6 5221.8 5143.2 5173.9 5188.6 5202.7 5219.0 5477.5 5519.2 5588.2 5667.3 5676.4 6202.0 6202.4 6203.0 6210.1 6212.8 5234.5 6162.2 6210.2 6221.8 6222.4 5659.0 5662.8 5757.8 5759.7 5761.6 6197.5 6232.6 6235.5 6240.5 6244.2 6068.1 6114.7 6117.2 6147.3 6158.0 6226.8 6232.4 6232.9 6242.4 6245.7 6060.2 6111.0 6177.1 6201.6 6222.3 6129.2 6134.7 6141.4 6145.3 6148.6 4809.1 4867.7 4888.4 4929.3 4970.8 4246.9 4298.3 4349.0 4385.6 4430.8 5563.3 5660.5 5694.9 5709.3 5754.9 6156.7 6160.4 6241.1 6252.6 6259.3 5685.7 5700.7 5703.7 5709.2 5721.6 5215.9 5310.4 5333.4 5337.5 5344.1 6216.3 6226.6 6244.0 6250.8 6287.9 6110.5 6203.3 6214.5 6219.5 6236.5 6283.3 6287.5 6299.7 6310.2 6310.9 6051.0 6127.2 6135.0 6154.1 6179.6 6141.8 6147.4 6189.2 6192.4 6239.2 5874.3 6018.8 6047.6 6051.8 6100.6 5941.7 5995.1 6047.4 6064.8 6088.4 4868.0 5842.8 5891.4 5911.3 5932.2 6048.3 6059.6 6074.0 6135.3 6139.1 5731.3 5843.8 5924.4 5937.3 5946.0 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:59380.75 Median:38213.81 stddev:117331.27 (307.0%) stddev-sans-first:117576.98 04:26:27 INFO - PROCESS | 1667 | Values: 445.4 548.4 583.7 598.6 641.1 30335.0 39412.8 39595.2 39703.2 39937.0 41360.6 42037.2 42117.4 42141.4 42162.6 8308.5 8946.4 9078.6 9515.7 9776.6 9582.5 9701.1 9749.2 9775.4 9867.0 9806.3 9896.2 9901.8 9912.3 9924.8 9815.4 9882.4 9883.3 9890.2 9897.0 9775.1 9921.0 9936.6 9944.9 9950.1 40945.6 41299.6 41474.0 41487.4 41497.8 3183.3 3227.3 3253.9 3397.3 3711.3 27045.7 27504.4 28829.6 28839.4 28913.0 2599.7 2635.2 2657.8 2660.7 2674.3 396633.0 398021.0 399309.0 400079.0 400851.0 65701.7 66203.0 66693.7 66728.3 66728.7 70307.3 70449.6 70476.9 70567.6 70806.3 16759.7 16959.6 17373.5 17397.2 17413.9 13119.6 13199.7 13226.7 13227.1 13233.0 20953.7 22016.7 22024.0 22037.7 22045.9 8000.5 9215.0 9393.4 9490.4 9503.1 736.4 1018.3 1027.0 1042.6 1089.4 27899.7 27966.0 28318.4 28512.6 28633.0 1072.6 1100.5 1119.9 1121.4 1189.9 14409.6 14493.9 14777.7 14879.7 15149.0 533903.0 539421.0 539594.0 539926.0 542929.0 59721.4 60369.0 60432.0 60445.0 60558.4 1271.7 1345.2 1454.6 1465.9 1497.6 27826.5 27942.7 29351.6 29701.3 29851.3 48409.0 48679.8 49158.0 49243.8 49253.0 367951.0 369926.0 370286.0 370605.0 370799.0 28076.3 32646.5 33170.7 33608.7 33937.0 35721.0 39113.0 40551.4 42255.8 42560.8 36028.6 38453.0 38521.2 39136.0 39568.8 36470.5 37070.0 37481.9 38145.6 38282.0 35830.8 35954.8 36248.6 37027.0 37218.6 32289.7 32733.8 32991.5 33195.2 33308.8 24385.0 24509.0 24782.6 25044.5 25100.0 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33183.36 Median:21034.79 stddev:98624.62 (468.9%) stddev-sans-first:98870.48 04:26:27 INFO - PROCESS | 1667 | Values: 354.7 363.8 365.8 366.7 368.5 19725.8 19741.6 21013.5 21033.7 21035.9 12079.1 12391.3 12403.8 12403.9 12412.0 5048.4 5285.4 5299.7 5964.1 5966.3 5868.2 5875.5 5918.7 5920.6 5930.7 5844.0 5901.0 6199.7 6385.3 6387.4 6338.0 6356.4 6360.9 6373.1 6382.7 5318.5 5520.9 5555.4 5651.9 5657.9 24683.8 24998.6 25157.5 25184.6 25592.0 1871.1 2027.4 2080.1 2377.4 2404.6 9299.5 10013.6 10048.3 10121.5 10184.7 1667.5 1713.8 1726.6 1755.5 1775.6 102287.5 104592.0 104757.5 105168.0 105205.0 11243.5 11282.3 11341.3 11345.5 11463.0 13537.8 13581.1 13588.6 13617.4 13620.9 6824.4 8009.2 8175.7 8179.6 8270.3 8021.7 8081.1 8087.1 8187.4 8206.1 4452.3 4475.3 4481.4 4488.4 4529.8 1441.4 1783.0 1821.5 1884.8 1889.6 858.3 882.4 957.4 1031.5 1063.8 16141.1 19184.5 20196.3 20517.4 20877.2 961.2 989.6 1004.2 1044.4 1066.4 10603.0 10884.0 10990.8 11053.3 11140.7 575063.1 582625.0 600650.0 601360.0 615750.0 82827.0 109913.5 112833.4 113274.0 114166.0 1007.8 1027.6 1050.5 1055.0 1056.2 17052.8 17822.9 17874.0 18108.6 18299.5 31801.2 40974.8 48126.8 49332.3 51058.7 74064.7 74382.0 75201.0 75643.0 75791.6 7538.2 7563.0 7605.0 7730.8 7848.1 8952.7 11560.2 12062.2 12362.6 12506.7 9750.8 10391.8 10722.5 10745.3 10839.3 7866.6 10612.4 10637.6 10664.8 10812.1 10647.2 10798.5 11094.0 11212.9 11231.8 7670.2 7799.1 7931.0 7937.1 8191.4 9450.8 10727.9 10766.5 11066.9 11090.4 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6002.96 Median:5436.48 stddev:3175.25 (58.4%) stddev-sans-first:3165.30 04:26:27 INFO - PROCESS | 1667 | Values: 1399.9 1618.0 1641.6 1649.5 2032.6 7899.1 8628.3 8782.3 8796.7 8801.7 8413.9 8674.0 8691.0 8691.7 8693.8 2166.5 2311.8 2344.6 2435.3 2485.4 2504.3 2515.5 2518.7 2520.5 2521.3 2418.6 2440.8 2447.8 2459.1 2459.7 2417.1 2449.1 2454.5 2476.4 2482.5 2460.8 2495.5 2500.2 2502.3 2512.9 8852.5 8939.6 8949.5 8951.6 8952.1 5339.9 5467.2 5497.4 5504.9 5511.3 3553.5 3635.0 3707.3 3710.6 3720.8 928.0 931.6 1001.0 1019.6 1061.2 11260.3 11414.1 11428.0 11476.3 11488.1 4745.0 4759.0 4792.4 4821.9 4851.5 9299.3 9299.7 9309.5 9309.6 9318.4 5423.5 5424.8 5426.3 5446.6 5487.9 4373.4 4509.5 4672.6 4755.5 4757.6 3753.4 3814.5 3828.7 3853.5 3862.4 1035.6 1185.3 1193.7 1207.1 1208.5 1093.2 1114.8 1130.1 1324.8 1423.3 8201.8 8238.0 8279.0 8285.2 8303.3 515.7 525.8 527.9 528.3 530.7 5179.0 5415.5 6318.9 6340.2 6371.3 10362.2 10577.0 10629.3 10677.5 10713.1 10226.5 10440.9 10465.1 10575.5 10595.5 8153.5 8292.3 8358.8 8385.5 8399.5 8042.7 8082.3 8092.9 8131.1 8187.7 9248.7 9334.2 9401.1 9443.2 9474.8 9782.5 9886.1 9995.3 10175.7 10227.6 6953.0 7100.9 7523.8 7716.0 7860.7 8332.1 8385.7 8391.9 8400.3 8426.5 7295.9 7357.6 7416.7 7499.2 7628.5 7247.1 7283.7 7289.5 7365.8 7391.2 7705.4 7734.3 7737.2 7741.8 7749.9 6923.2 7014.3 7035.3 7064.3 7076.4 7103.4 7182.7 7248.5 7297.8 7304.3 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5702.99 Median:6451.26 stddev:1809.19 (28.0%) stddev-sans-first:1768.29 04:26:27 INFO - PROCESS | 1667 | Values: 303.7 328.9 332.2 335.1 338.0 5593.9 6449.7 6555.0 6559.2 6570.8 6489.4 6517.0 6520.0 6544.7 6545.6 4652.1 4736.2 4743.6 4860.9 4878.3 4852.7 4863.0 4872.9 4873.1 4883.2 4271.1 4546.7 4809.2 4835.9 4838.3 4625.2 4696.4 4786.2 4814.9 4818.3 4125.8 4137.7 4146.4 4147.9 4153.5 6167.4 6192.3 6195.3 6206.8 6216.4 5569.2 5602.5 5652.3 5652.7 5656.4 6692.3 6892.4 6900.0 6906.0 6911.0 4177.0 4397.2 4599.6 4679.5 4688.8 5964.2 7146.2 7253.5 7326.5 7328.5 4751.8 4763.9 4764.8 4767.1 4776.2 4798.5 4815.2 4817.5 4823.8 4828.7 4617.9 5618.6 5651.9 5658.0 5673.1 5773.6 6371.3 6892.0 6938.1 6955.2 1674.2 1685.8 1693.1 1696.2 1700.3 1042.6 1071.2 1105.3 1109.4 1123.5 6413.3 6435.2 6444.4 6467.5 6474.1 7128.6 7134.4 7140.8 7156.6 7158.6 6441.3 6452.8 6453.3 6456.9 6485.8 3752.5 3810.1 3812.4 3814.2 3818.7 7185.9 7518.0 7521.7 7523.9 7525.7 7386.6 7456.4 7486.3 7514.6 7539.9 6159.8 7606.4 7637.5 7639.3 7640.9 6990.6 7280.6 7281.2 7295.2 7304.7 7163.8 7223.1 7227.3 7232.8 7243.5 7625.4 7634.3 7636.4 7643.3 7649.9 3815.4 4574.1 4620.7 4632.2 4648.8 7006.7 7278.9 7287.8 7289.8 7293.5 7001.5 7027.0 7055.9 7065.7 7068.7 6971.1 7035.8 7040.7 7045.6 7051.2 6848.8 6850.4 6850.5 6859.1 6859.8 6697.5 6730.7 7021.2 7022.5 7044.6 6099.4 6593.3 6720.2 6744.4 6873.5 04:26:27 INFO - PROCESS | 1667 | 04:26:27 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18362.08 Median:607.34 stddev:25893.85 (4263.5%) stddev-sans-first:25932.33 04:26:27 INFO - PROCESS | 1667 | Values: 650.4 689.8 705.2 724.7 761.3 15105.9 15289.9 15325.8 15342.6 16287.9 16414.9 16441.2 16464.3 16504.0 16572.4 749.5 759.5 927.4 930.4 930.4 935.1 950.1 950.3 950.3 951.6 977.0 982.8 983.7 984.1 984.4 792.5 975.5 978.6 984.8 996.6 745.6 747.1 748.5 749.6 759.7 15359.8 15393.9 15417.5 15420.5 15445.2 12204.8 12274.6 12313.6 12535.5 12563.2 10089.1 10146.3 10207.5 10541.1 11041.4 3081.2 3483.1 3522.6 3634.0 3635.1 80998.0 81498.6 82343.6 84241.2 84482.6 9342.8 9375.8 9410.5 9429.9 9755.0 16956.0 20986.0 20990.0 20995.1 21018.2 5819.0 7456.0 7529.3 7540.3 7637.8 3446.8 4102.2 4118.9 4152.9 4380.9 3578.7 3583.0 3628.2 3630.8 3631.5 657.4 679.3 680.4 686.8 688.9 478.3 554.3 581.6 589.1 600.0 7943.3 8011.4 8102.1 8212.5 8253.7 586.7 590.2 593.9 595.6 614.7 3719.9 3804.8 3815.7 3824.8 3852.4 95202.0 95383.0 96975.0 97593.5 97597.0 55053.0 76701.0 77160.8 78040.6 78271.6 67832.0 68371.7 68573.7 70759.0 71985.3 8263.8 8440.5 8445.0 8450.7 8473.7 43500.9 48279.8 49431.8 51194.7 51983.7 66109.7 67267.0 69512.0 70238.6 70674.0 10864.6 11030.3 11224.2 11302.8 11505.9 12073.8 12171.6 12447.6 12453.1 12462.3 11187.6 11467.1 11468.8 11744.2 11796.4 10785.8 10846.8 10892.1 10897.0 11379.3 11183.2 11240.4 11269.4 11426.5 11541.5 9173.6 9342.4 9535.3 9638.6 9958.6 9025.0 9157.3 9259.1 9410.7 9452.9 04:26:27 INFO - PROCESS | 1667 | -------- Summary: end -------- 04:26:27 INFO - PROCESS | 1667 | 04:26:28 INFO - TEST-INFO | 1667: exit 0 04:26:28 INFO - TEST-OK | dromaeo_css | took 1113661ms 04:26:28 INFO - TEST-START | kraken 04:26:28 INFO - operating with platform_type : mac_ 04:26:28 INFO - Initialising browser for kraken test... 04:26:28 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpyMeFU5/profile http://localhost:49278/getInfo.html) 04:26:30 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 04:26:30 INFO - PROCESS | 1672 | colorDepth:24 04:26:30 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 04:26:30 INFO - PROCESS | 1672 | __metrics 04:26:30 INFO - PROCESS | 1672 | 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" 04:26:30 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:26:30 INFO - TEST-INFO | 1672: exit 0 04:26:30 INFO - Browser initialized. 04:26:30 INFO - Running cycle 1/1 for kraken test... 04:26:30 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpyMeFU5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:42 INFO - PROCESS | 1674 | RSS: Main: 247361536 04:26:42 INFO - PROCESS | 1674 | 04:26:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:46 INFO - PROCESS | 1674 | RSS: Main: 291672064 04:26:46 INFO - PROCESS | 1674 | 04:26:48 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 04:26:49 INFO - PROCESS | 1674 | RSS: Main: 302714880 04:26:49 INFO - PROCESS | 1674 | 04:26:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 04:26:53 INFO - PROCESS | 1674 | RSS: Main: 288514048 04:26:53 INFO - PROCESS | 1674 | 04:26:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 04:26:55 INFO - PROCESS | 1674 | RSS: Main: 290832384 04:26:55 INFO - PROCESS | 1674 | 04:26:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:58 INFO - PROCESS | 1674 | RSS: Main: 291262464 04:26:58 INFO - PROCESS | 1674 | 04:27:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:01 INFO - PROCESS | 1674 | RSS: Main: 292487168 04:27:01 INFO - PROCESS | 1674 | 04:27:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:05 INFO - PROCESS | 1674 | RSS: Main: 291483648 04:27:05 INFO - PROCESS | 1674 | 04:27:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 04:27:08 INFO - PROCESS | 1674 | RSS: Main: 291332096 04:27:08 INFO - PROCESS | 1674 | 04:27:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:27:10 INFO - PROCESS | 1674 | RSS: Main: 324870144 04:27:10 INFO - PROCESS | 1674 | 04:27:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:27:13 INFO - PROCESS | 1674 | RSS: Main: 324452352 04:27:13 INFO - PROCESS | 1674 | 04:27:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:27:15 INFO - PROCESS | 1674 | RSS: Main: 332992512 04:27:15 INFO - PROCESS | 1674 | 04:27:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:27:19 INFO - PROCESS | 1674 | RSS: Main: 334336000 04:27:19 INFO - PROCESS | 1674 | 04:27:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:27:22 INFO - PROCESS | 1674 | RSS: Main: 334462976 04:27:22 INFO - PROCESS | 1674 | 04:27:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 04:27:24 INFO - PROCESS | 1674 | RSS: Main: 394448896 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | __start_tp_report 04:27:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 04:27:24 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 04:27:24 INFO - PROCESS | 1674 | |i|pagename|runs| 04:27:24 INFO - PROCESS | 1674 | |0;ai-astar;111;108;111;110;111;112;116;111;111;111 04:27:24 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;120;144;159;119;146;151;153;165;120 04:27:24 INFO - PROCESS | 1674 | |2;audio-dft;185;184;185;186;186;182;183;185;184;180 04:27:24 INFO - PROCESS | 1674 | |3;audio-fft;77;71;90;76;56;59;66;96;101;81 04:27:24 INFO - PROCESS | 1674 | |4;audio-oscillator;91;94;128;78;81;81;114;78;77;125 04:27:24 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;86;83;86;85;87;84;87;83;86;83 04:27:24 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;92;92;95;93;93;99;94;93;91 04:27:24 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;87;85;84;84;85;85;99;136;71 04:27:24 INFO - PROCESS | 1674 | |8;json-parse-financial;56;56;55;55;55;54;54;64;53;54 04:27:24 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;65;65;72;77;70;68;68;69;68;69 04:27:24 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;83;83;83;83;84;82;79;81;83;84 04:27:24 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;118;157;142;129;138;119;118;120;120;118 04:27:24 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;136;128;140;139;140;127;136;138;136;139 04:27:24 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;68;67;67;67;67 04:27:24 INFO - PROCESS | 1674 | __end_tp_report 04:27:24 INFO - PROCESS | 1674 | __start_cc_report 04:27:24 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1292 04:27:24 INFO - PROCESS | 1674 | __end_cc_report 04:27:24 INFO - PROCESS | 1674 | __startTimestamp1458818844212__endTimestamp 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | ------- Summary: start ------- 04:27:24 INFO - PROCESS | 1674 | Number of tests: 14 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:2.11 04:27:24 INFO - PROCESS | 1674 | Values: 111.0 108.0 111.0 110.0 111.0 112.0 116.0 111.0 111.0 111.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:152.00 stddev:17.29 (11.4%) stddev-sans-first:17.81 04:27:24 INFO - PROCESS | 1674 | Values: 155.0 120.0 144.0 159.0 119.0 146.0 151.0 153.0 165.0 120.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:1.89 (1.0%) stddev-sans-first:1.96 04:27:24 INFO - PROCESS | 1674 | Values: 185.0 184.0 185.0 186.0 186.0 182.0 183.0 185.0 184.0 180.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:77.30 Median:76.50 stddev:15.07 (19.7%) stddev-sans-first:15.98 04:27:24 INFO - PROCESS | 1674 | Values: 77.0 71.0 90.0 76.0 56.0 59.0 66.0 96.0 101.0 81.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.50 stddev:20.17 (25.4%) stddev-sans-first:21.35 04:27:24 INFO - PROCESS | 1674 | Values: 91.0 94.0 128.0 78.0 81.0 81.0 114.0 78.0 77.0 125.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.63 (1.9%) stddev-sans-first:1.69 04:27:24 INFO - PROCESS | 1674 | Values: 86.0 83.0 86.0 85.0 87.0 84.0 87.0 83.0 86.0 83.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:2.22 (2.4%) stddev-sans-first:2.35 04:27:24 INFO - PROCESS | 1674 | Values: 93.0 92.0 92.0 95.0 93.0 93.0 99.0 94.0 93.0 91.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:85.00 stddev:17.44 (20.5%) stddev-sans-first:18.41 04:27:24 INFO - PROCESS | 1674 | Values: 85.0 87.0 85.0 84.0 84.0 85.0 85.0 99.0 136.0 71.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.10 (5.6%) stddev-sans-first:3.28 04:27:24 INFO - PROCESS | 1674 | Values: 56.0 56.0 55.0 55.0 55.0 54.0 54.0 64.0 53.0 54.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:3.48 (5.0%) stddev-sans-first:3.36 04:27:24 INFO - PROCESS | 1674 | Values: 65.0 65.0 72.0 77.0 70.0 68.0 68.0 69.0 68.0 69.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 04:27:24 INFO - PROCESS | 1674 | Values: 83.0 83.0 83.0 83.0 84.0 82.0 79.0 81.0 83.0 84.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:124.50 stddev:13.53 (10.9%) stddev-sans-first:13.87 04:27:24 INFO - PROCESS | 1674 | Values: 118.0 157.0 142.0 129.0 138.0 119.0 118.0 120.0 120.0 118.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.90 Median:138.50 stddev:4.70 (3.4%) stddev-sans-first:4.99 04:27:24 INFO - PROCESS | 1674 | Values: 136.0 128.0 140.0 139.0 140.0 127.0 136.0 138.0 136.0 139.0 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 04:27:24 INFO - PROCESS | 1674 | Values: 68.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 04:27:24 INFO - PROCESS | 1674 | -------- Summary: end -------- 04:27:24 INFO - PROCESS | 1674 | 04:27:24 INFO - TEST-INFO | 1674: exit 0 04:27:24 INFO - TEST-OK | kraken | took 56904ms 04:27:24 INFO - SUITE-END | took 1170s 04:27:25 INFO - Completed test suite (00:19:30) 04:27:25 INFO - javascript benchmark 04:27:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3455.429854074078, 3498.9650103498957, 3500.191743571611, 3545.804980726059, 3575.6960658344037, 5607.775688972436, 5668.57485688574, 5673.914891276634, 5706.0585003474425, 5760.366359700435, 5690.118031705092, 5695.288088988877, 5739.885202295952, 5836.503897168735, 5862.76548938043, 5117.641765076446, 5131.409887862887, 5170.121079416508, 5184.559312458446, 5299.920501192485, 5243.370795504526, 5262.736863156846, 5278.630495865291, 5305.495977882095, 5345.118055520835, 5087.923681144785, 5098.541131298182, 5205.115130427817, 5211.661242019257, 5224.686518808883, 5182.97408512955, 5189.481051894818, 5208.088584497697, 5220.582353411718, 5221.791128354861, 5143.202803565453, 5173.922391164136, 5188.610854185951, 5202.661826981234, 5219.0083884061905, 5477.4796394342475, 5519.172124181365, 5588.21764952907, 5667.263255776764, 5676.403977582336, 6202.00767877142, 6202.41077097675, 6203.038529028008, 6210.099535567318, 6212.751489940397, 5234.528892399664, 6162.22972128484, 6210.1616281801835, 6221.813345599639, 6222.377762223787, 5658.971705141448, 5662.773489060474, 5757.769689212427, 5759.65442073477, 5761.596688231867, 6197.4732147767945, 6232.594881332699, 6235.501159907197, 6240.500759939194, 6244.188255526752, 6068.096643010931, 6114.724837382329, 6117.188044311343, 6147.323794382614, 6158.0, 6226.813195604049, 6232.439080482688, 6232.906506402408, 6242.438180563771, 6245.718942647592, 6060.212172417558, 6110.953680641517, 6177.073438984098, 6201.596896201822, 6222.3466536013975, 6129.233845769279, 6134.681512609229, 6141.424638644238, 6145.262568491809, 6148.600340977822, 4809.134355815917, 4867.683600565952, 4888.364512613338, 4929.285253638202, 4970.826021089245, 4246.915061698749, 4298.312270036779, 4348.956510434855, 4385.583369579948, 4430.8449204277695, 5563.304586926634, 5660.5471562274915, 5694.943050569441, 5709.262652900135, 5754.9424505754405, 6156.661383623854, 6160.383961603893, 6241.095041218998, 6252.624842509464, 6259.280182778948, 5685.715714214272, 5700.714964251771, 5703.657780533182, 5709.200711900337, 5721.5708821838525, 5215.921761173586, 5310.415854256029, 5333.359996800331, 5337.519623233928, 5344.064788661969, 6216.347283535164, 6226.59527130735, 6243.968780156161, 6250.812475625738, 6287.874242515216, 6110.4980065817745, 6203.348648391854, 6214.533909956862, 6219.502439804714, 6236.469900058364, 6283.2774230962195, 6287.528435367457, 6299.716512757029, 6310.242770867341, 6310.905336420049, 6050.969745151246, 6127.220070483952, 6135.0, 6154.076888466766, 6179.62922224668, 6141.823559979257, 6147.385261473817, 6189.164462797465, 6192.411720886689, 6239.188905442264, 5874.295084589877, 6018.8194354169445, 6047.606905551125, 6051.7579296827635, 6100.572959892942, 5941.732622031933, 5995.130706047686, 6047.425494578008, 6064.787732429344, 6088.360722124113, 4867.975660121819, 5842.795502157574, 5891.440313170413, 5911.261092363455, 5932.16949627044, 6048.304444988707, 6059.575829691879, 6073.969630151821, 6135.263768347827, 6139.140520327069, 5731.340895797037, 5843.766249350148, 5924.407559244041, 5937.2578427696535, 5946.0], "unit": "score", "name": "dojo.html", "value": 5667.893287503903}, {"lowerIsBetter": false, "replicates": [445.3898159521456, 548.4241546376305, 583.6837930466796, 598.5858528183021, 641.1184621145923, 30335.0, 39412.80293598532, 39595.20809583814, 39703.20593588126, 39937.0, 41360.58639413605, 42037.15925681492, 42117.36823947635, 42141.36787948183, 42162.578374216246, 8308.501489910594, 8946.41848279863, 9078.591463384131, 9515.714528564155, 9776.560054797515, 9582.472963986978, 9701.126898579127, 9749.220062395027, 9775.364601300927, 9867.0, 9806.313558050939, 9896.208303335716, 9901.801963960717, 9912.256580756437, 9924.751881202992, 9815.362001469917, 9882.357646752938, 9883.258755593288, 9890.20878329732, 9896.950515247414, 9775.120239178437, 9920.95039524805, 9936.602535898555, 9944.850827237597, 9950.054744799232, 40945.59054409448, 41299.58700412988, 41474.0, 41487.37768933469, 41497.79251103755, 3183.331500384899, 3227.3222623249144, 3253.8535765890592, 3397.3286730745226, 3711.2577484502935, 27045.729542704517, 27504.44991100187, 28829.56755648667, 28839.423211535654, 28913.0, 2599.7400259974042, 2635.19489149931, 2657.7740892024203, 2660.720624334456, 2674.2645772412548, 396633.0, 398021.0098949487, 399309.0, 400079.0, 400851.0, 65701.67149164224, 66203.0, 66693.66612667816, 66728.33271667222, 66728.6663566679, 70307.2969270311, 70449.64775176092, 70476.94284585633, 70567.64716176386, 70806.29193707996, 16759.748603770953, 16959.576010599834, 17373.47879563615, 17397.217125229396, 17413.91293043527, 13119.606411807661, 13199.67000824987, 13226.73546529064, 13227.140235884637, 13233.0, 20953.68569471459, 22016.669749953762, 22024.008919598655, 22037.669434958487, 22045.89770511468, 8000.479968802009, 9215.0, 9393.436393816393, 9490.430574165572, 9503.144716975366, 736.3934140688926, 1018.2821111116644, 1026.9794604108026, 1042.6298663974333, 1089.3844977587637, 27899.721002789713, 27966.0, 28318.43363132767, 28512.572311415344, 28633.0, 1072.570971611346, 1100.4772732951783, 1119.8544189255344, 1121.377635412354, 1189.9405029748477, 14409.567712968628, 14493.855061449462, 14777.704445911022, 14879.735222506208, 15149.0, 533903.0, 539421.0, 539594.0, 539926.0, 542929.0, 59721.40278597245, 60369.0, 60432.0, 60445.0, 60558.39441605616, 1271.6820794801115, 1345.2466618693563, 1454.5854431487187, 1465.8607432293916, 1497.5956491747168, 27826.469544175266, 27942.720572794013, 29351.55972660369, 29701.257468563457, 29851.338942247687, 48409.0, 48679.756601216766, 49157.99999999857, 49243.753781230866, 49253.01493970172, 367951.0, 369926.0, 370286.0, 370605.0, 370799.0, 28076.29809254785, 32646.51030234596, 33170.673173072806, 33608.66391336153, 33937.0, 35721.0, 39113.0, 40551.3917291235, 42255.788721057426, 42560.78719606382, 36028.639713603574, 38453.0, 38521.22957540777, 39136.02159946024, 39568.80215598903, 36470.45914753934, 37070.0, 37481.87554373264, 38145.61854381532, 38282.0, 35830.82084589561, 35954.8202258987, 36248.63751362558, 37027.0, 37218.62781372152, 32289.70841166421, 32733.836330818194, 32991.50512742359, 33195.17012074718, 33308.833455832566, 24385.0, 24509.0, 24782.628260576468, 25044.499110018063, 25100.0], "unit": "score", "name": "ext.html", "value": 19713.815763266644}, {"lowerIsBetter": false, "replicates": [354.6666133834196, 363.75446573562846, 365.8481730082016, 366.74327970420694, 368.4933216826863, 19725.81645101293, 19741.605167896632, 21013.47466313343, 21033.68449473255, 21035.894820525875, 12079.094067944896, 12391.25652460853, 12403.813942790865, 12403.93798031011, 12412.0, 5048.394192696873, 5285.445028272034, 5299.735013249322, 5964.105384192362, 5966.254218222723, 5868.207791948096, 5875.500582450497, 5918.674472903988, 5920.585559010871, 5930.733117009745, 5844.006518891777, 5901.026330655437, 6199.659018753967, 6385.297617262097, 6387.393197646239, 6337.98592225244, 6356.364363563653, 6360.872782544347, 6373.107764912916, 6382.744690212409, 5318.521333080042, 5520.944790552083, 5555.416681248492, 5651.943480565183, 5657.9434205658235, 24683.765811709523, 24998.625020624706, 25157.49685006308, 25184.622230666555, 25592.0, 1871.1392759330724, 2027.4019164346553, 2080.053575623088, 2377.3699969508093, 2404.5671779079757, 9299.535023248878, 10013.59945602175, 10048.346857454242, 10121.49392530378, 10184.694459166238, 1667.5330907345963, 1713.837185467391, 1726.6460375622967, 1755.4821327708357, 1775.6359946211126, 102287.48856255745, 104592.0, 104757.47621261845, 105168.0, 105205.0, 11243.494042768096, 11282.266652667551, 11341.26281791681, 11345.546178152781, 11463.025642820287, 13537.796933046013, 13581.11722738019, 13588.59234222975, 13617.387217575233, 13620.863791362157, 6824.351686589766, 8009.199080091944, 8175.71385001534, 8179.591020448954, 8270.338372930151, 8021.679132834738, 8081.111077781439, 8087.069986951458, 8187.38594605407, 8206.097329293772, 4452.30989196675, 4475.261581839025, 4481.395011673448, 4488.371627972087, 4529.773511324421, 1441.373002743789, 1783.0371599336472, 1821.5264031351944, 1884.8209420105068, 1889.56539995799, 858.274757829633, 882.3558802074522, 957.3968399908152, 1031.515187861704, 1063.8404239364002, 16141.112238826743, 19184.520386990156, 20196.29312974039, 20517.38447846567, 20877.164913403292, 961.2262128986233, 989.5893204320126, 1004.161525126513, 1044.4307852220559, 1066.36018388966, 10602.992715691997, 10883.983369629808, 10990.780184396268, 11053.28153670009, 11140.721481963015, 575063.1246843738, 582625.0, 600650.0, 601360.0, 615750.0, 82827.0, 109913.45043274733, 112833.43583282195, 113274.0, 114166.0, 1007.8185926533148, 1027.5992362978445, 1050.5377633840933, 1055.0293729768478, 1056.2131212246925, 17052.829471705125, 17822.91088544549, 17874.016929069025, 18108.637827243117, 18299.54251143732, 31801.204969875937, 40974.79512602418, 48126.75936620295, 49332.26001609907, 51058.74470627623, 74064.74017115218, 74382.0, 75201.0, 75643.0, 75791.62104189444, 7538.208488108669, 7562.962185189039, 7604.96197519031, 7730.845383092419, 7848.136704962564, 8952.731418057469, 11560.190786644855, 12062.215955962834, 12362.629121126382, 12506.687332816753, 9750.80498390014, 10391.792164156826, 10722.463876805972, 10745.301555398873, 10839.295445795999, 7866.6066696666085, 10612.363258204532, 10637.574497020032, 10664.786704266027, 10812.135029197803, 10647.201459890694, 10798.514066867167, 11094.0, 11212.887871121184, 11231.775364492501, 7670.156282808998, 7799.142094369501, 7930.9603451982375, 7937.126916039347, 8191.385646076449, 9450.763730906783, 10727.946360268148, 10766.461676915966, 11066.889331106586, 11090.390028548507], "unit": "score", "name": "jquery.html", "value": 9105.123981656237}, {"lowerIsBetter": false, "replicates": [1399.9370028348724, 1617.9676406471872, 1641.5813967438305, 1649.5381293237897, 2032.6036422897541, 7899.052113746351, 8628.266597339225, 8782.341324400664, 8796.69211577595, 8801.691940782066, 8413.915860841389, 8674.0, 8691.000534938485, 8691.652333906652, 8693.826123477527, 2166.480044789255, 2311.757265487129, 2344.6248600223967, 2435.257246539805, 2485.3662316109458, 2504.3238325652064, 2515.5220508103494, 2518.659980902582, 2520.4959008198343, 2521.281434791085, 2418.576749068906, 2440.8291419600546, 2447.840890342122, 2459.139301244559, 2459.7048354197523, 2417.093589903786, 2449.1183174057323, 2454.460018795871, 2476.418041760185, 2482.5407299649623, 2460.815438842094, 2495.4510007798253, 2500.199936020474, 2502.311864237331, 2512.8617926014063, 8852.51311177885, 8939.64241430342, 8949.507777072258, 8951.641934322619, 8952.060033696433, 5339.919901201485, 5467.20725494801, 5497.367802702701, 5504.862378440531, 5511.283533140706, 3553.5202747629255, 3634.9818250908575, 3707.277080969212, 3710.610385909468, 3720.813959302051, 928.0302084321833, 931.5528546297747, 1000.9640022576598, 1019.6125472320545, 1061.1881910338598, 11260.324380537195, 11414.14393920451, 11428.028617567517, 11476.311421314664, 11488.080953523699, 4745.0, 4758.976205118952, 4792.400949881265, 4821.855344339676, 4851.466338702739, 9299.256059515223, 9299.67451139207, 9309.487978161265, 9309.581068851918, 9318.440893546409, 5423.457654234624, 5424.810131645373, 5426.348838139448, 5446.618736688394, 5487.890242195133, 4373.387725718402, 4509.526499717548, 4672.556107169813, 4755.548222918817, 4757.571818536279, 3753.3806921858136, 3814.4659747635355, 3828.693704503633, 3853.460515527828, 3862.362710152793, 1035.6478797208986, 1185.3125187391292, 1193.7254431480808, 1207.076586411396, 1208.528673817212, 1093.2128867215592, 1114.8216285394299, 1130.1298000539539, 1324.8145259663654, 1423.252792284059, 8201.753947381589, 8238.011438627404, 8279.047909490366, 8285.171482851667, 8303.252707256375, 515.7343967856557, 525.8448757616512, 527.9498447647468, 528.3184691747603, 530.7372850439058, 5178.97410512945, 5415.53967912724, 6318.905216421757, 6340.175777149033, 6371.33101024395, 10362.222833287533, 10577.048065674126, 10629.255952083435, 10677.51951162184, 10713.142948564097, 10226.539805708611, 10440.947795261127, 10465.110465610509, 10575.524101415454, 10595.470226488645, 8153.470024448392, 8292.253697167283, 8358.791030224293, 8385.538795366192, 8399.496030238206, 8042.67829286822, 8082.2725954664365, 8092.878606820785, 8131.146229645802, 8187.71343002992, 9248.722538323862, 9334.206592439446, 9401.10689484498, 9443.150116489549, 9474.810503790024, 9782.510874456106, 9886.060824221975, 9995.250356223458, 10175.7456063599, 10227.59089636436, 6953.0, 7100.928990710234, 7523.774286771406, 7715.961420192863, 7860.685572577033, 8332.125126861592, 8385.664573416994, 8391.874121888055, 8400.327973761961, 8426.452280601741, 7295.8540829184185, 7357.558546487228, 7416.66625001887, 7499.1750907399055, 7628.504147230412, 7247.13034435871, 7283.708651654087, 7289.5261807982315, 7365.815854603464, 7391.189158655949, 7705.383569314329, 7734.265244801735, 7737.226277372218, 7741.845163096594, 7749.92250077492, 6923.238443771282, 7014.263502332182, 7035.296470352924, 7064.32888875556, 7076.398506127037, 7103.431725461847, 7182.748603798842, 7248.456365772694, 7297.817554560966, 7304.306090921354], "unit": "score", "name": "mootools.html", "value": 4795.51971850608}, {"lowerIsBetter": false, "replicates": [303.69478673932696, 328.87831502344136, 332.20934176659546, 335.09190094842984, 338.04165191681597, 5593.916091258624, 6449.677516124193, 6555.049517819919, 6559.180102487189, 6570.835729106775, 6489.383508566691, 6516.96741516293, 6519.967400163005, 6544.70548825304, 6545.639989800571, 4652.092841895815, 4736.218523943562, 4743.573078422941, 4860.927086093711, 4878.268259761037, 4852.708837469745, 4862.97568512157, 4872.878178045542, 4873.147199240118, 4883.19427294496, 4271.145770845827, 4546.727196368212, 4809.182438985381, 4835.903281934359, 4838.322634831109, 4625.236835922069, 4696.4129483814695, 4786.1863483207935, 4814.9277760833265, 4818.349522814446, 4125.773082480462, 4137.689673274516, 4146.398772178048, 4147.875563733093, 4153.54311025787, 6167.44492995628, 6192.28788689302, 6195.31851496335, 6206.751729930797, 6216.440520353145, 5569.220309156722, 5602.523785478198, 5652.265205523256, 5652.689102099383, 5656.377798442168, 6692.330766923317, 6892.414144797698, 6899.9650052492525, 6906.033155358254, 6910.961266426366, 4176.979115104436, 4397.2304846651705, 4599.632029437637, 4679.532046795327, 4688.812447502096, 5964.224650795456, 7146.213916469184, 7253.492255542114, 7326.4505162113055, 7328.487005909588, 4751.809927602857, 4763.857084287477, 4764.76176191196, 4767.094252092092, 4776.21192503233, 4798.5441383068555, 4815.181419158752, 4817.542333478314, 4823.782929768169, 4828.66199366048, 4617.930731039037, 5618.578606604521, 5651.943480565224, 5658.0, 5673.149027645886, 5773.6431938494425, 6371.299157092716, 6891.96620506928, 6938.063361446241, 6955.1653801544135, 1674.2047527424377, 1685.7639930409753, 1693.09419460588, 1696.151924037981, 1700.3368686212386, 1042.5985995391677, 1071.2340676416243, 1105.264998775805, 1109.378747901178, 1123.5168877382803, 6413.262474815363, 6435.195600549931, 6444.420002199825, 6467.482601391877, 6474.061261117112, 7128.643567821692, 7134.393576546052, 7140.7500737474975, 7156.60638664868, 7158.570485770871, 6441.323661015525, 6452.838679032968, 6453.257875344301, 6456.903146452807, 6485.805425837232, 3752.5496940366784, 3810.066533699206, 3812.370958791824, 3814.1608846053823, 3818.7326887118193, 7185.89221161683, 7518.0, 7521.699132034657, 7523.924760752432, 7525.736599219001, 7386.556806591621, 7456.40348772097, 7486.32623063916, 7514.624268786539, 7539.924600754032, 6159.784407545714, 7606.353459955966, 7637.5035622685455, 7639.312461878458, 7640.885386719204, 6990.566933778665, 7280.599567023864, 7281.19906810261, 7295.161056478573, 7304.671289791866, 7163.820904477429, 7223.097112860893, 7227.313405226495, 7232.783016509513, 7243.45674074436, 7625.389968802593, 7634.312911837961, 7636.427267954815, 7643.273888980538, 7649.885251721117, 3815.389537673959, 4574.085182963354, 4620.745858977789, 4632.166210082218, 4648.83729069481, 7006.684699188447, 7278.854422911406, 7287.817804554928, 7289.817754556178, 7293.52592081513, 7001.474889383215, 7026.9648651756415, 7055.858882822212, 7065.717371305091, 7068.71725130989, 6971.0937578116545, 7035.803913334643, 7040.683169257498, 7045.577265364094, 7051.189113251837, 6848.842614576392, 6850.38346548813, 6850.486213533905, 6859.108315918898, 6859.794206173823, 6697.464202863856, 6730.6971186297715, 7021.192562855133, 7022.54353467023, 7044.577325360495, 6099.420555047263, 6593.340665933369, 6720.1599800025, 6744.393004629607, 6873.48448866347], "unit": "score", "name": "prototype.html", "value": 5103.917684221249}, {"lowerIsBetter": false, "replicates": [650.4438704907303, 689.7827184436902, 705.1925545250687, 724.688383994882, 761.2691815856778, 15105.924470377646, 15289.923550382246, 15325.770113448307, 15342.616434589141, 16287.918560407212, 16414.917925410387, 16441.177941102927, 16464.259108340124, 16504.009759414443, 16572.41996530122, 749.5315427857589, 759.4569882533987, 927.3647551427293, 930.371998900741, 930.3766476460787, 935.1163150822475, 950.1068995144576, 950.3442624589046, 950.3490109275134, 951.6478902805972, 977.0180968127022, 982.8230918434679, 983.7343917142367, 984.099548912744, 984.4487087231138, 792.5205250823255, 975.5463709375139, 978.5938835383307, 984.7636567223886, 996.6312464388222, 745.608555508357, 747.1333253426054, 748.5172064018732, 749.6476655971685, 759.7454852624378, 15359.846401535953, 15393.923030384889, 15417.537473875802, 15420.537383878502, 15445.227738613024, 12204.816927746091, 12274.570390036306, 12313.630591082281, 12535.498580056787, 12563.246205227624, 10089.142422893989, 10146.340487868265, 10207.489625518769, 10541.104006159485, 11041.447927603587, 3081.1834863761123, 3483.0943954571994, 3522.559680039995, 3634.036980200249, 3635.1093981974323, 80998.0, 81498.59250703768, 82343.5882820588, 84241.15758842394, 84482.57758711166, 9342.766430839283, 9375.812483750424, 9410.527568897405, 9429.905700942903, 9755.00425841344, 16956.0, 20986.0, 20990.0, 20995.055222515024, 21018.159273628884, 5819.0, 7455.962720186364, 7529.284717951786, 7540.3213710766295, 7637.809054773564, 3446.758726889144, 4102.241085399151, 4118.855840045584, 4152.854650087293, 4380.8685739427865, 3578.6958108560543, 3583.014670965453, 3628.219932714479, 3630.8366123524506, 3631.4915911772373, 657.3689258312074, 679.3342524326089, 680.3876511140014, 686.7939618114546, 688.8553403785261, 478.27780052121545, 554.3071161048689, 581.6393835821817, 589.1280904261716, 599.9970000149972, 7943.324817390471, 8011.359091272684, 8102.149274326229, 8212.507249565046, 8253.688134517772, 586.6568057686301, 590.173756740558, 593.8604427959426, 595.627732667083, 614.6926536731634, 3719.8698045568276, 3804.771713697187, 3815.7328986970647, 3824.8470061197795, 3852.3643598805884, 95202.0, 95383.0, 96975.0, 97593.51203243938, 97597.02402975879, 55053.0, 76701.0, 77160.84258736011, 78040.60979695065, 78271.60864195642, 67832.0, 68371.65814170898, 68573.65713171502, 70759.0, 71985.28014719891, 8263.834723305621, 8440.53577053268, 8444.957775211085, 8450.66197352099, 8473.745787626382, 43500.91247718832, 48279.75860120677, 49431.75284123556, 51194.74402627963, 51983.74008129935, 66109.66945165243, 67267.0, 69512.0, 70238.59522809618, 70674.0, 10864.619738309122, 11030.283031603241, 11224.214304998572, 11302.830457543309, 11505.942470287595, 12073.818892716792, 12171.634850954486, 12447.564335248222, 12453.06602004835, 12462.314572698226, 11187.552497899993, 11467.139964502863, 11468.770624587294, 11744.17790754639, 11796.410179491162, 10785.838212426663, 10846.783064338826, 10892.074173695324, 10897.019268265576, 11379.317240965569, 11183.161262905152, 11240.4379781009, 11269.380184089627, 11426.542938282708, 11541.538338466367, 9173.633054677739, 9342.439453632804, 9535.284853636143, 9638.566264517973, 9958.55186516594, 9024.96382954394, 9157.267418606629, 9259.074092590687, 9410.717678469384, 9452.858207126761], "unit": "score", "name": "yui.html", "value": 6944.461040386923}], "name": "dromaeo_css", "value": 7464.17689967459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 111.0, 110.0, 111.0, 112.0, 116.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 144.0, 159.0, 119.0, 146.0, 151.0, 153.0, 165.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 185.0, 186.0, 186.0, 182.0, 183.0, 185.0, 184.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 90.0, 76.0, 56.0, 59.0, 66.0, 96.0, 101.0, 81.0], "unit": "score", "name": "audio-fft", "value": 77.3}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 128.0, 78.0, 81.0, 81.0, 114.0, 78.0, 77.0, 125.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 86.0, 85.0, 87.0, 84.0, 87.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 92.0, 95.0, 93.0, 93.0, 99.0, 94.0, 93.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 84.0, 84.0, 85.0, 85.0, 99.0, 136.0, 71.0], "unit": "score", "name": "imaging-desaturate", "value": 90.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 54.0, 54.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 72.0, 77.0, 70.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 84.0, 82.0, 79.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [118.0, 157.0, 142.0, 129.0, 138.0, 119.0, 118.0, 120.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.9}, {"lowerIsBetter": true, "replicates": [136.0, 128.0, 140.0, 139.0, 140.0, 127.0, 136.0, 138.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1417.3000000000002}]} 04:27:25 INFO - Return code: 0 04:27:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:27:25 ERROR - # TBPL SUCCESS # 04:27:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:25 INFO - 2016-03-24 04:27:25.515 screenresolution[1678:10200] starting screenresolution argv=screenresolution get 04:27:25 INFO - 2016-03-24 04:27:25.518 screenresolution[1678:10200] Display 0: 1600x1200x32@60 04:27:25 INFO - 2016-03-24 04:27:25.524 screenresolution[1679:10203] starting screenresolution argv=screenresolution list 04:27:25 INFO - Available Modes on Display 0 04:27:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:25 INFO - Intel Iris: 04:27:25 INFO - Chipset Model: Intel Iris 04:27:25 INFO - Type: GPU 04:27:25 INFO - Bus: Built-In 04:27:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:25 INFO - Vendor: Intel (0x8086) 04:27:25 INFO - Device ID: 0x0a2e 04:27:25 INFO - Revision ID: 0x0009 04:27:25 INFO - Displays: 04:27:25 INFO - Display: 04:27:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:25 INFO - Display Serial Number: 1600x1200 60 04:27:25 INFO - Main Display: Yes 04:27:25 INFO - Mirror: Off 04:27:25 INFO - Online: Yes 04:27:25 INFO - Rotation: Supported 04:27:25 INFO - Return code: 0 04:27:25 INFO - Running post-action listener: _resource_record_post_action 04:27:25 INFO - Running post-run listener: _resource_record_post_run 04:27:26 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34110976; Write bytes: 707140096; Read time: 353; Write time: 2042 04:27:26 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403259904; Write bytes: 405239808; Read time: 30032; Write time: 817 04:27:26 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32329216; Write bytes: 301052416; Read time: 333; Write time: 1223 04:27:26 INFO - Running post-run listener: _upload_blobber_files 04:27:26 INFO - Blob upload gear active. 04:27:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:27:26 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 04:27:26 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'] 04:27:26 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 04:27:27 INFO - (blobuploader) - INFO - Open directory for files ... 04:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:27 INFO - (blobuploader) - INFO - Done attempting. 04:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:29 INFO - (blobuploader) - INFO - Done attempting. 04:27:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:29 INFO - Return code: 0 04:27:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c29e8b2833ec3294126bec355557fa1dbf6a3c56fc078bb3439dc643b6d55a24a8e8ee32b380cb67e0f7e6e2713ec6ed8ad88cb8df52e37843f434e8e2d217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e978f11d0c52e4f019c57360d29b7a24092e7c35b1f042c57d37e02e6ac4498c47a395a36ee29336f885aa510e9d21063659004840320f2c7fa5d47daafc34f1"} 04:27:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:29 INFO - Contents: 04:27:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68c29e8b2833ec3294126bec355557fa1dbf6a3c56fc078bb3439dc643b6d55a24a8e8ee32b380cb67e0f7e6e2713ec6ed8ad88cb8df52e37843f434e8e2d217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e978f11d0c52e4f019c57360d29b7a24092e7c35b1f042c57d37e02e6ac4498c47a395a36ee29336f885aa510e9d21063659004840320f2c7fa5d47daafc34f1"} 04:27:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:29 INFO - Copying logs to upload dir... 04:27:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.124966 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-03-24 04:27:29.155829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 04:27:29.160247) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/68c29e8b2833ec3294126bec355557fa1dbf6a3c56fc078bb3439dc643b6d55a24a8e8ee32b380cb67e0f7e6e2713ec6ed8ad88cb8df52e37843f434e8e2d217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e978f11d0c52e4f019c57360d29b7a24092e7c35b1f042c57d37e02e6ac4498c47a395a36ee29336f885aa510e9d21063659004840320f2c7fa5d47daafc34f1"} build_url:https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/ELHx6pFJQEWsXN7KXoN4fg/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/68c29e8b2833ec3294126bec355557fa1dbf6a3c56fc078bb3439dc643b6d55a24a8e8ee32b380cb67e0f7e6e2713ec6ed8ad88cb8df52e37843f434e8e2d217", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e978f11d0c52e4f019c57360d29b7a24092e7c35b1f042c57d37e02e6ac4498c47a395a36ee29336f885aa510e9d21063659004840320f2c7fa5d47daafc34f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 04:27:29.191166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:27:29.191452) ========= 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.D5u9Mm4uFG/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.7ldxzIFJth/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 04:27:29.240019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 04:27:29.240315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 04:27:29.240672) ========= ========= Total master_lag: 0.33 =========