builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0119 starttime: 1458254884.77 results: success (0) buildid: 20160317144713 builduid: 0c5fb13884694fe9a92049add63b9fb0 revision: cfc060dca9c59e5265379c871b0ce176e592fb08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.768199) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.768656) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.768981) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005584 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.793317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.793678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.811164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.811529) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005463 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.861512) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.861960) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.862368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.862734) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-17 15:48:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 44.5M=0s 2016-03-17 15:48:04 (44.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.985625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:04.985950) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.026586 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.034328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.034705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cfc060dca9c59e5265379c871b0ce176e592fb08 --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 cfc060dca9c59e5265379c871b0ce176e592fb08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-17 15:48:05,112 truncating revision to first 12 chars 2016-03-17 15:48:05,112 Setting DEBUG logging. 2016-03-17 15:48:05,113 attempt 1/10 2016-03-17 15:48:05,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cfc060dca9c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 15:48:05,740 unpacking tar archive at: fx-team-cfc060dca9c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.919579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.919887) ========= echo cfc060dca9c59e5265379c871b0ce176e592fb08 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cfc060dca9c59e5265379c871b0ce176e592fb08'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 cfc060dca9c59e5265379c871b0ce176e592fb08 program finished with exit code 0 elapsedTime=0.005666 script_repo_revision: 'cfc060dca9c59e5265379c871b0ce176e592fb08' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.969483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.969839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 15:48:05.983648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-17 15:48:05.983966) ========= /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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:06 INFO - MultiFileLogger online at 20160317 15:48:06 in /builds/slave/test 15:48:06 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 15:48:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:06 INFO - {'append_to_log': False, 15:48:06 INFO - 'base_work_dir': '/builds/slave/test', 15:48:06 INFO - 'blob_upload_branch': 'Fx-Team', 15:48:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:06 INFO - 'branch': 'Fx-Team', 15:48:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:06 INFO - 'config_files': ('talos/mac_config.py',), 15:48:06 INFO - 'default_actions': ('clobber', 15:48:06 INFO - 'read-buildbot-config', 15:48:06 INFO - 'download-and-extract', 15:48:06 INFO - 'populate-webroot', 15:48:06 INFO - 'create-virtualenv', 15:48:06 INFO - 'install', 15:48:06 INFO - 'run-tests'), 15:48:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:06 INFO - 'download_minidump_stackwalk': True, 15:48:06 INFO - 'download_symbols': 'ondemand', 15:48:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:06 INFO - 'installer_path': 'installer.exe', 15:48:06 INFO - 'log_level': 'info', 15:48:06 INFO - 'log_name': 'talos', 15:48:06 INFO - 'log_to_console': True, 15:48:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:48:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:48:06 INFO - 'opt_config_files': (), 15:48:06 INFO - 'pip_index': False, 15:48:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:48:06 INFO - 'cmd': ('bash', 15:48:06 INFO - '-c', 15:48:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:48:06 INFO - 'enabled': True, 15:48:06 INFO - 'halt_on_failure': False, 15:48:06 INFO - 'name': 'check_screen_resolution'},), 15:48:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:48:06 INFO - 'cmd': ('bash', 15:48:06 INFO - '-c', 15:48:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:48:06 INFO - 'enabled': True, 15:48:06 INFO - 'halt_on_failure': False, 15:48:06 INFO - 'name': 'check_screen_resolution'},), 15:48:06 INFO - 'run_cmd_checks_enabled': True, 15:48:06 INFO - 'sps_profile': False, 15:48:06 INFO - 'sps_profile_interval': 0, 15:48:06 INFO - 'suite': 'dromaeojs', 15:48:06 INFO - 'system_bits': '32', 15:48:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:06 INFO - 'title': 't-yosemite-r7-0119', 15:48:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:06 INFO - 'use_talos_json': True, 15:48:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:06 INFO - 'work_dir': 'build'} 15:48:06 INFO - ##### 15:48:06 INFO - ##### Running clobber step. 15:48:06 INFO - ##### 15:48:06 INFO - Running pre-action listener: _resource_record_pre_action 15:48:06 INFO - Running main action method: clobber 15:48:06 INFO - rmtree: /builds/slave/test/build 15:48:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:07 INFO - Running post-action listener: _resource_record_post_action 15:48:07 INFO - ##### 15:48:07 INFO - ##### Running read-buildbot-config step. 15:48:07 INFO - ##### 15:48:07 INFO - Running pre-action listener: _resource_record_pre_action 15:48:07 INFO - Running main action method: read_buildbot_config 15:48:07 INFO - Using buildbot properties: 15:48:07 INFO - { 15:48:07 INFO - "project": "", 15:48:07 INFO - "product": "firefox", 15:48:07 INFO - "script_repo_revision": "production", 15:48:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:48:07 INFO - "repository": "", 15:48:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:48:07 INFO - "buildid": "20160317144713", 15:48:07 INFO - "pgo_build": "False", 15:48:07 INFO - "basedir": "/builds/slave/test", 15:48:07 INFO - "buildnumber": 547, 15:48:07 INFO - "slavename": "t-yosemite-r7-0119", 15:48:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 15:48:07 INFO - "platform": "yosemite_r7", 15:48:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:48:07 INFO - "branch": "fx-team", 15:48:07 INFO - "repo_path": "integration/fx-team", 15:48:07 INFO - "revision": "cfc060dca9c59e5265379c871b0ce176e592fb08", 15:48:07 INFO - "stage_platform": "macosx64", 15:48:07 INFO - "builduid": "0c5fb13884694fe9a92049add63b9fb0", 15:48:07 INFO - "slavebuilddir": "test" 15:48:07 INFO - } 15:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:48:07 INFO - Running post-action listener: _resource_record_post_action 15:48:07 INFO - ##### 15:48:07 INFO - ##### Running download-and-extract step. 15:48:07 INFO - ##### 15:48:07 INFO - Running pre-action listener: _resource_record_pre_action 15:48:07 INFO - Running main action method: download_and_extract 15:48:07 INFO - mkdir: /builds/slave/test/build/tests 15:48:07 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')]} 15:48:07 INFO - https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:09 INFO - Downloaded 1199 bytes. 15:48:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:48:09 INFO - Using the following test package requirements: 15:48:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:48:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:48:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:48:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'jsshell-mac.zip'], 15:48:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:48:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:48:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:48:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:48:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:48:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:48:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:48:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:48: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')]} 15:48:09 INFO - https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:10 INFO - Downloaded 17870535 bytes. 15:48:10 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'] 15:48:10 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 15:48:13 INFO - Return code: 0 15:48:13 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 15:48: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')]} 15:48:13 INFO - https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:18 INFO - Downloaded 17870535 bytes. 15:48:18 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'] 15:48:18 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 15:48:22 INFO - Return code: 0 15:48: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')]} 15:48:22 INFO - https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:24 INFO - Downloaded 10846565 bytes. 15:48:24 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'] 15:48:24 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 15:48:24 INFO - Return code: 0 15:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:24 INFO - https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZvuqPvnS96U11VY5MirIg/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 15:48:30 INFO - Downloaded 111205163 bytes. 15:48:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:48:30 INFO - mkdir: /builds/slave/test/properties 15:48:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:30 INFO - Contents: 15:48:30 INFO - build_url:https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:48:31 INFO - Running post-action listener: _resource_record_post_action 15:48:31 INFO - Running post-action listener: set_extra_try_arguments 15:48:31 INFO - ##### 15:48:31 INFO - ##### Running populate-webroot step. 15:48:31 INFO - ##### 15:48:31 INFO - Running pre-action listener: _resource_record_pre_action 15:48:31 INFO - Running main action method: populate_webroot 15:48:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:31 INFO - '--tppagecycles', 15:48:31 INFO - '7'], 15:48:31 INFO - 'tests': ['tsvgm']}}, 15:48:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:48:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:48:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'tests': ['damp', 'tps']}, 15:48:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['damp', 'tps']}, 15:48:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:48:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:31 INFO - 'other': {'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'other_l64': {'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'other_nol64': {'tests': ['a11yr', 15:48:31 INFO - 'ts_paint', 15:48:31 INFO - 'tpaint', 15:48:31 INFO - 'sessionrestore', 15:48:31 INFO - 'sessionrestore_no_auto_restore', 15:48:31 INFO - 'tabpaint']}, 15:48:31 INFO - 'svgr': {'tests': ['tsvgx', 15:48:31 INFO - 'tsvgr_opacity', 15:48:31 INFO - 'tart', 15:48:31 INFO - 'tscrollx', 15:48:31 INFO - 'cart']}, 15:48:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['tsvgx', 15:48:31 INFO - 'tsvgr_opacity', 15:48:31 INFO - 'tart', 15:48:31 INFO - 'tscrollx', 15:48:31 INFO - 'cart']}, 15:48:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'tests': ['tp5o']}, 15:48:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'talos_options': ['--e10s'], 15:48:31 INFO - 'tests': ['tp5o']}, 15:48:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'talos_options': ['--xperf_path', 15:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:31 INFO - 'tests': ['tp5n']}, 15:48:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:31 INFO - 'talos_options': ['--e10s', 15:48:31 INFO - '--xperf_path', 15:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:31 INFO - 'tests': ['tp5n']}}, 15:48:31 INFO - 'talos.zip': {'path': '', 15:48:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:31 INFO - Running post-action listener: _resource_record_post_action 15:48:31 INFO - ##### 15:48:31 INFO - ##### Running create-virtualenv step. 15:48:31 INFO - ##### 15:48:31 INFO - Running pre-action listener: _resource_record_pre_action 15:48:31 INFO - Running main action method: create_virtualenv 15:48:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:31 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 15:48:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:31 INFO - Using real prefix '/tools/python27' 15:48:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:35 INFO - Installing pip.................done. 15:48:35 INFO - Return code: 0 15:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:35 INFO - 'HOME': '/Users/cltbld', 15:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:35 INFO - 'LOGNAME': 'cltbld', 15:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:35 INFO - 'MOZ_NO_REMOTE': '1', 15:48:35 INFO - 'NO_EM_RESTART': '1', 15:48:35 INFO - 'PAGER': '/bin/cat', 15:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:35 INFO - 'PWD': '/builds/slave/test', 15:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:35 INFO - 'SHELL': '/bin/bash', 15:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:35 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:35 INFO - 'USER': 'cltbld', 15:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:35 INFO - 'XPC_FLAGS': '0x0', 15:48:35 INFO - 'XPC_SERVICE_NAME': '0', 15:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:35 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 15:48:35 INFO - Cleaning up... 15:48:35 INFO - Return code: 0 15:48:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:35 INFO - 'HOME': '/Users/cltbld', 15:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:35 INFO - 'LOGNAME': 'cltbld', 15:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:35 INFO - 'MOZ_NO_REMOTE': '1', 15:48:35 INFO - 'NO_EM_RESTART': '1', 15:48:35 INFO - 'PAGER': '/bin/cat', 15:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:35 INFO - 'PWD': '/builds/slave/test', 15:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:35 INFO - 'SHELL': '/bin/bash', 15:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:35 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:35 INFO - 'USER': 'cltbld', 15:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:35 INFO - 'XPC_FLAGS': '0x0', 15:48:35 INFO - 'XPC_SERVICE_NAME': '0', 15:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:35 INFO - Downloading/unpacking psutil>=0.7.1 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:38 INFO - Installing collected packages: psutil 15:48:38 INFO - Running setup.py install for psutil 15:48:38 INFO - building 'psutil._psutil_osx' extension 15:48:38 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 15:48:38 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 15:48:39 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 15:48:39 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 15:48:39 INFO - building 'psutil._psutil_posix' extension 15:48:39 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 15:48:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:48:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:48:39 INFO - ^ 15:48:39 INFO - 1 warning generated. 15:48:39 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 15:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:39 INFO - Successfully installed psutil 15:48:39 INFO - Cleaning up... 15:48:39 INFO - Return code: 0 15:48:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:39 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:39 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 15:48:39 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 15:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:39 INFO - 'HOME': '/Users/cltbld', 15:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:39 INFO - 'LOGNAME': 'cltbld', 15:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:39 INFO - 'MOZ_NO_REMOTE': '1', 15:48:39 INFO - 'NO_EM_RESTART': '1', 15:48:39 INFO - 'PAGER': '/bin/cat', 15:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:39 INFO - 'PWD': '/builds/slave/test', 15:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:39 INFO - 'SHELL': '/bin/bash', 15:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:39 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:39 INFO - 'USER': 'cltbld', 15:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:39 INFO - 'XPC_FLAGS': '0x0', 15:48:39 INFO - 'XPC_SERVICE_NAME': '0', 15:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:48:39 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 15:48:39 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 15:48:39 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 15:48:39 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 15:48:39 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 15:48:39 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 15:48:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:48:42 INFO - Installing collected packages: mozsystemmonitor 15:48:42 INFO - Running setup.py install for mozsystemmonitor 15:48:42 INFO - Successfully installed mozsystemmonitor 15:48:42 INFO - Cleaning up... 15:48:42 INFO - Return code: 0 15:48:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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', '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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:48: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 blobuploader==1.2.4 15:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:42 INFO - 'HOME': '/Users/cltbld', 15:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:42 INFO - 'LOGNAME': 'cltbld', 15:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:42 INFO - 'MOZ_NO_REMOTE': '1', 15:48:42 INFO - 'NO_EM_RESTART': '1', 15:48:42 INFO - 'PAGER': '/bin/cat', 15:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:42 INFO - 'PWD': '/builds/slave/test', 15:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:42 INFO - 'SHELL': '/bin/bash', 15:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:42 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:42 INFO - 'USER': 'cltbld', 15:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:42 INFO - 'XPC_FLAGS': '0x0', 15:48:42 INFO - 'XPC_SERVICE_NAME': '0', 15:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:42 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 15:48:42 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 15:48:42 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 15:48:42 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 15:48:42 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 15:48:42 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 15:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:46 INFO - Downloading docopt-0.6.1.tar.gz 15:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:46 INFO - Running setup.py install for blobuploader 15:48:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:46 INFO - Running setup.py install for requests 15:48:46 INFO - Running setup.py install for docopt 15:48:47 INFO - Successfully installed blobuploader requests docopt 15:48:47 INFO - Cleaning up... 15:48:47 INFO - Return code: 0 15:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:47 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:47 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 15:48:47 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 15:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:47 INFO - 'HOME': '/Users/cltbld', 15:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:47 INFO - 'LOGNAME': 'cltbld', 15:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:47 INFO - 'MOZ_NO_REMOTE': '1', 15:48:47 INFO - 'NO_EM_RESTART': '1', 15:48:47 INFO - 'PAGER': '/bin/cat', 15:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:47 INFO - 'PWD': '/builds/slave/test', 15:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:47 INFO - 'SHELL': '/bin/bash', 15:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:47 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:47 INFO - 'USER': 'cltbld', 15:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:47 INFO - 'XPC_FLAGS': '0x0', 15:48:47 INFO - 'XPC_SERVICE_NAME': '0', 15:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Z6qlcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-UcKIsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-s91IcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-SqzGCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:47 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-9_E2Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-7eJ4YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-iI4WYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-rU5ixw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-p0lovf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-IMIdgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-RSTgjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-bVRXvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-JOx7r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-NE3xQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:48 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-HZuynz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:49 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-mQh8mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:49 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Ja2qqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:49 INFO - Running setup.py install for manifestparser 15:48:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:49 INFO - Running setup.py install for mozcrash 15:48:49 INFO - Running setup.py install for mozdebug 15:48:49 INFO - Running setup.py install for mozdevice 15:48:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:49 INFO - Running setup.py install for mozfile 15:48:50 INFO - Running setup.py install for mozhttpd 15:48:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for mozinfo 15:48:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for mozInstall 15:48:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for mozleak 15:48:50 INFO - Running setup.py install for mozlog 15:48:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for moznetwork 15:48:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for mozprocess 15:48:51 INFO - Running setup.py install for mozprofile 15:48:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozrunner 15:48:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozscreenshot 15:48:51 INFO - Running setup.py install for moztest 15:48:51 INFO - Running setup.py install for mozversion 15:48:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:51 INFO - Cleaning up... 15:48:51 INFO - Return code: 0 15:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:51 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:51 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 15:48:51 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 15:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:51 INFO - 'HOME': '/Users/cltbld', 15:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:51 INFO - 'LOGNAME': 'cltbld', 15:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:51 INFO - 'MOZ_NO_REMOTE': '1', 15:48:51 INFO - 'NO_EM_RESTART': '1', 15:48:51 INFO - 'PAGER': '/bin/cat', 15:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:51 INFO - 'PWD': '/builds/slave/test', 15:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:51 INFO - 'SHELL': '/bin/bash', 15:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:51 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:51 INFO - 'USER': 'cltbld', 15:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:51 INFO - 'XPC_FLAGS': '0x0', 15:48:51 INFO - 'XPC_SERVICE_NAME': '0', 15:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-JgwrtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-s6BaI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-cbG8ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-STF96_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-KMmCA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-BnSr8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zTHh1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-3GKh2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-25w_Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-tdwxeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-XYaiqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-pf7HB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-pg4Gus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Kgs3r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-yxRcHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-uLQ6fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:53 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Qf_9E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:53 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)) 15:48:53 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)) 15:48:53 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)) 15:48:53 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)) 15:48:53 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)) 15:48:53 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)) 15:48:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:56 INFO - Downloading blessings-1.6.tar.gz 15:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:56 INFO - Installing collected packages: blessings 15:48:56 INFO - Running setup.py install for blessings 15:48:56 INFO - Successfully installed blessings 15:48:56 INFO - Cleaning up... 15:48:56 INFO - Return code: 0 15:48:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:56 INFO - Reading from file tmpfile_stdout 15:48:56 INFO - Current package versions: 15:48:56 INFO - blessings == 1.6 15:48:56 INFO - blobuploader == 1.2.4 15:48:56 INFO - docopt == 0.6.1 15:48:56 INFO - manifestparser == 1.1 15:48:56 INFO - mozInstall == 1.12 15:48:56 INFO - mozcrash == 0.17 15:48:56 INFO - mozdebug == 0.1 15:48:56 INFO - mozdevice == 0.48 15:48:56 INFO - mozfile == 1.2 15:48:56 INFO - mozhttpd == 0.7 15:48:56 INFO - mozinfo == 0.9 15:48:56 INFO - mozleak == 0.1 15:48:56 INFO - mozlog == 3.1 15:48:56 INFO - moznetwork == 0.27 15:48:56 INFO - mozprocess == 0.22 15:48:56 INFO - mozprofile == 0.28 15:48:56 INFO - mozrunner == 6.11 15:48:56 INFO - mozscreenshot == 0.1 15:48:56 INFO - mozsystemmonitor == 0.0 15:48:56 INFO - moztest == 0.7 15:48:56 INFO - mozversion == 1.4 15:48:56 INFO - psutil == 3.1.1 15:48:56 INFO - requests == 1.2.3 15:48:56 INFO - wsgiref == 0.1.2 15:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:56 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 15:48:56 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 15:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:56 INFO - 'HOME': '/Users/cltbld', 15:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:56 INFO - 'LOGNAME': 'cltbld', 15:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:56 INFO - 'MOZ_NO_REMOTE': '1', 15:48:56 INFO - 'NO_EM_RESTART': '1', 15:48:56 INFO - 'PAGER': '/bin/cat', 15:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:56 INFO - 'PWD': '/builds/slave/test', 15:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:56 INFO - 'SHELL': '/bin/bash', 15:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:56 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:56 INFO - 'USER': 'cltbld', 15:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:56 INFO - 'XPC_FLAGS': '0x0', 15:48:56 INFO - 'XPC_SERVICE_NAME': '0', 15:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 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)) 15:48:57 INFO - Cleaning up... 15:48:57 INFO - Return code: 0 15:48:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:57 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:48:57 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 15:48:57 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 15:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:48:57 INFO - 'HOME': '/Users/cltbld', 15:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:48:57 INFO - 'LOGNAME': 'cltbld', 15:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:57 INFO - 'MOZ_NO_REMOTE': '1', 15:48:57 INFO - 'NO_EM_RESTART': '1', 15:48:57 INFO - 'PAGER': '/bin/cat', 15:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:57 INFO - 'PWD': '/builds/slave/test', 15:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:48:57 INFO - 'SHELL': '/bin/bash', 15:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:48:57 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:48:57 INFO - 'USER': 'cltbld', 15:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:57 INFO - 'XPC_FLAGS': '0x0', 15:48:57 INFO - 'XPC_SERVICE_NAME': '0', 15:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:57 INFO - Downloading/unpacking jsonschema 15:48:57 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 15:48:57 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 15:48:57 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 15:48:57 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 15:48:57 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 15:48:57 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 15:48:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:00 INFO - warning: no files found matching '*.txt' 15:49:00 INFO - no previously-included directories found matching 'build' 15:49:00 INFO - no previously-included directories found matching 'dist' 15:49:00 INFO - no previously-included directories found matching '.git*' 15:49:00 INFO - Installing collected packages: jsonschema, functools32 15:49:00 INFO - Running setup.py install for functools32 15:49:00 INFO - warning: no files found matching '*.txt' 15:49:00 INFO - no previously-included directories found matching 'build' 15:49:00 INFO - no previously-included directories found matching 'dist' 15:49:00 INFO - no previously-included directories found matching '.git*' 15:49:00 INFO - Successfully installed jsonschema functools32 15:49:00 INFO - Cleaning up... 15:49:00 INFO - Return code: 0 15:49:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:00 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 0x10d335a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d345420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0785ba340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, '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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 15:49:00 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 15:49:00 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 15:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:00 INFO - 'HOME': '/Users/cltbld', 15:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:00 INFO - 'LOGNAME': 'cltbld', 15:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:00 INFO - 'MOZ_NO_REMOTE': '1', 15:49:00 INFO - 'NO_EM_RESTART': '1', 15:49:00 INFO - 'PAGER': '/bin/cat', 15:49:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:00 INFO - 'PWD': '/builds/slave/test', 15:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:00 INFO - 'SHELL': '/bin/bash', 15:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:49:00 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:00 INFO - 'USER': 'cltbld', 15:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:00 INFO - 'XPC_FLAGS': '0x0', 15:49:00 INFO - 'XPC_SERVICE_NAME': '0', 15:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 INFO - Downloading/unpacking flake8 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:49:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:49:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:04 INFO - no previously-included directories found matching 'docs/_build' 15:49:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:49:04 INFO - Running setup.py install for pep8 15:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:49:04 INFO - no previously-included directories found matching 'docs/_build' 15:49:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:49:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:49:04 INFO - Cleaning up... 15:49:04 INFO - Return code: 0 15:49:05 INFO - Running post-action listener: _resource_record_post_action 15:49:05 INFO - Running post-action listener: _start_resource_monitoring 15:49:05 INFO - Starting resource monitoring. 15:49:05 INFO - ##### 15:49:05 INFO - ##### Running install step. 15:49:05 INFO - ##### 15:49:05 INFO - Running pre-action listener: _resource_record_pre_action 15:49:05 INFO - Running main action method: install 15:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:05 INFO - Reading from file tmpfile_stdout 15:49:05 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:05 INFO - Reading from file tmpfile_stdout 15:49:05 INFO - Output received: 15:49:05 INFO - Usage: mozinstall [options] installer 15:49:05 INFO - Options: 15:49:05 INFO - -h, --help show this help message and exit 15:49:05 INFO - -d DEST, --destination=DEST 15:49:05 INFO - Directory to install application into. [default: 15:49:05 INFO - "/builds/slave/test"] 15:49:05 INFO - --app=APP Application being installed. [default: firefox] 15:49:05 INFO - mkdir: /builds/slave/test/build/application 15:49:05 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'] 15:49:05 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 15:49:39 INFO - Reading from file tmpfile_stdout 15:49:39 INFO - Output received: 15:49:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:49:39 INFO - Running post-action listener: _resource_record_post_action 15:49:39 INFO - ##### 15:49:39 INFO - ##### Running run-tests step. 15:49:39 INFO - ##### 15:49:39 INFO - Running pre-action listener: _resource_record_pre_action 15:49:39 INFO - Running main action method: run_tests 15:49:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:49:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:49:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:49:39 INFO - 2016-03-17 15:49:39.273 screenresolution[1641:7336] starting screenresolution argv=screenresolution get 15:49:39 INFO - 2016-03-17 15:49:39.275 screenresolution[1641:7336] Display 0: 1600x1200x32@60 15:49:39 INFO - 2016-03-17 15:49:39.281 screenresolution[1642:7339] starting screenresolution argv=screenresolution list 15:49:39 INFO - Available Modes on Display 0 15:49:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:49:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:49:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:49:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:49:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:49:39 INFO - Intel Iris: 15:49:39 INFO - Chipset Model: Intel Iris 15:49:39 INFO - Type: GPU 15:49:39 INFO - Bus: Built-In 15:49:39 INFO - VRAM (Dynamic, Max): 1536 MB 15:49:39 INFO - Vendor: Intel (0x8086) 15:49:39 INFO - Device ID: 0x0a2e 15:49:39 INFO - Revision ID: 0x0009 15:49:39 INFO - Displays: 15:49:39 INFO - Display: 15:49:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:49:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:49:39 INFO - Display Serial Number: 1600x1200 60 15:49:39 INFO - Main Display: Yes 15:49:39 INFO - Mirror: Off 15:49:39 INFO - Online: Yes 15:49:39 INFO - Rotation: Supported 15:49:39 INFO - Return code: 0 15:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:39 INFO - Python 2.7.3 15:49:39 INFO - Return code: 0 15:49:39 INFO - grabbing minidump binary from tooltool 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:39 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 0x10d1d4e00>, '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 0x10cffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:39 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 15:49:39 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 15:49:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:39 INFO - Return code: 0 15:49:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:49:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:49:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:49:40 INFO - Return code: 0 15:49:40 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/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 15:49:40 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/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --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 15:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LK1EV7jVpi/Render', 15:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:49:40 INFO - 'HOME': '/Users/cltbld', 15:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:49:40 INFO - 'LOGNAME': 'cltbld', 15:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:40 INFO - 'MOZ_NO_REMOTE': '1', 15:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:40 INFO - 'NO_EM_RESTART': '1', 15:49:40 INFO - 'PAGER': '/bin/cat', 15:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:40 INFO - 'PWD': '/builds/slave/test', 15:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:49:40 INFO - 'SHELL': '/bin/bash', 15:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B3kc1Lmtyd/Listeners', 15:49:40 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 15:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:49:40 INFO - 'USER': 'cltbld', 15:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:40 INFO - 'XPC_FLAGS': '0x0', 15:49:40 INFO - 'XPC_SERVICE_NAME': '0', 15:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:49:40 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/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 15:49:41 INFO - mozversion application_buildid: 20160317144713 15:49:41 INFO - mozversion application_changeset: cfc060dca9c59e5265379c871b0ce176e592fb08 15:49:41 INFO - mozversion application_display_name: Nightly 15:49:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:41 INFO - mozversion application_name: Firefox 15:49:41 INFO - mozversion application_remotingname: firefox 15:49:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:49:41 INFO - mozversion application_vendor: Mozilla 15:49:41 INFO - mozversion application_version: 48.0a1 15:49:41 INFO - mozversion platform_buildid: 20160317144713 15:49:41 INFO - mozversion platform_changeset: cfc060dca9c59e5265379c871b0ce176e592fb08 15:49:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:49:41 INFO - mozversion platform_version: 48.0a1 15:49:41 INFO - using testdate: 1458254981 15:49:41 INFO - actual date: 1458254981 15:49:41 INFO - starting webserver on 'localhost:49270' 15:49:41 INFO - SUITE-START | Running 2 tests 15:49:41 INFO - TEST-START | dromaeo_css 15:49:41 INFO - operating with platform_type : mac_ 15:49:41 INFO - Initialising browser for dromaeo_css test... 15:49:41 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpVmMvwn/profile http://localhost:49270/getInfo.html) 15:49:43 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 15:49:43 INFO - PROCESS | 1660 | colorDepth:24 15:49:43 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 15:49:43 INFO - PROCESS | 1660 | __metrics 15:49:43 INFO - PROCESS | 1660 | 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" 15:49:43 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:49:43 INFO - TEST-INFO | 1660: exit 0 15:49:43 INFO - Browser initialized. 15:49:43 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:44 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpVmMvwn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:55 INFO - PROCESS | 1663 | RSS: Main: 243433472 15:49:55 INFO - PROCESS | 1663 | 15:50:46 INFO - PROCESS | 1663 | 1458255046572 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] 15:52:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 15:52:58 INFO - PROCESS | 1663 | RSS: Main: 380571648 15:52:58 INFO - PROCESS | 1663 | 15:56:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 15:56:01 INFO - PROCESS | 1663 | RSS: Main: 380604416 15:56:01 INFO - PROCESS | 1663 | 15:59:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 15:59:04 INFO - PROCESS | 1663 | RSS: Main: 373395456 15:59:04 INFO - PROCESS | 1663 | 16:02:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:02:07 INFO - PROCESS | 1663 | RSS: Main: 337846272 16:02:07 INFO - PROCESS | 1663 | 16:05:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:05:10 INFO - PROCESS | 1663 | RSS: Main: 339439616 16:05:10 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:08:13 INFO - PROCESS | 1663 | RSS: Main: 450371584 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | __start_tp_report 16:08:13 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:08:13 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:08:13 INFO - PROCESS | 1663 | |i|pagename|runs| 16:08:13 INFO - PROCESS | 1663 | |0;dojo.html;3016.2760937375024;3370.6797854203846;3456.2741824216914;3496.842642081106;3515.8417871195784;5446.673199608016;5535.501804837564;5608.663480191186;5615.522680572151;5617.915731264029;5613.07384281594;5632.155176723493;5661.830145095643;5736.541076713864;5772.682502462363;5045.823396181135;5073.188289873612;5095.566876815476;5105.923411148836;5205.973970130144;5102.795888164487;5185.688858668473;5233.110371236899;5239.187925871496;5271.5782737381105;4252.787360631972;5010.048090862724;5084.644074914758;5120.052790233819;5148.047611191922;5117.948820511821;5134.306868572732;5134.845954621367;5137.871553211162;5166.715830629314;5058.721770302632;5116.155834287375;5126.461721519224;5127.077126117298;5135.255387968724;5446.2375267462585;5537.390887002426;5543.8891222175735;5553.111502159635;5573.693446860421;6066.848328791772;6068.6358818471035;6071.2714474263375;6075.696215189223;6086.995645718451;5206.713630750307;6118.418750218722;6125.540584456184;6137.285055221596;6144.662043587601;4695.976520117378;5655.886882262373;5676.659400435987;5678.801241956553;5684.289463816982;5190.134373214803;6175.938240617536;6205.782797602153;6259.1550140730415;6287.811365659038;6040.184575082396;6049.213602231682;6058.333583305833;6065.029595264825;6077.483413909778;6180.969095154495;6190.535709821781;6192.071189321638;6196.442320191204;6198.876022479615;5949.494292985145;6034.547408944347;6059.878802424015;6062.878742425215;6069.332373438918;6021.939780602225;6044.7582096716515;6049.969750151309;6064.151018857364;6102.786402475892;4798.424189097261;4825.252085926687;4835.879103022453;4837.395325584302;4841.370621819211;3491.5984661763714;4272.594103560157;4308.073764140725;4363.301871700576;4408.404865343202;5569.805056822992;5575.024370735106;5580.414056524007;5594.804181853697;5643.463870932337;6011.699415029231;6064.605800622945;6151.169592105098;6166.4758495527485;6184.196054512884;5545.611807173459;5584.413636568183;5605.7197140142825;5607.271054762937;5652.18043383707;5241.947580524222;5274.077036518594;5300.70846103468;5310.787568497294;5322.494363035506;6197.349278325892;6239.937600624117;6241.843953901189;6243.687815609202;6256.280527739368;6122.581127188433;6170.228721409824;6233.875322493615;6237.313895471404;6257.530685198537;6219;6226.283977342482;6228.190335256388;6238.095476155841;6279.591826531261;5979.880402391841;6077.6961151943115;6082.756689732361;6094.695265236632;6107.450329470369;6134.079888016655;6177.320494745484;6189.257289125334;6207.937920620917;6211;5003.399592048831;5845.853853653693;5998;6037.607555508878;6052.455279024909;5845.678487683218;5957.553183511167;6002.7298771554515;6022.879542409215;6051.7579296827635;5858.062709966555;5859.648421094748;5869.618474799125;5870.207521984648;5920.911186332122;6046.5767396281835;6062.727177277121;6063.514918806397;6064.332923378337;6067.635941843503;5714.685692286964;5809.2738407699035;5814.94185058144;5855.94144058554;5863.648181109147 16:08:13 INFO - PROCESS | 1663 | |1;ext.html;491.61162681481585;576.187575518519;579.4842590094817;631.9194177955695;635.9650219237941;38312.616873831255;39119.99999999996;39144.412833807444;39183.80408097963;39194;41777.58222417782;42379.78810105953;42398.78800606;42462.7876860616;42501.57498425015;9654.903450965507;9875.407475551454;9891.851622225673;9894.307398482073;9907.504624768733;9744.902550974506;9902.950485247564;9904.752381190492;9904.950475247613;9920.503974801268;9861.802763944717;9891.208703303719;9936.90063099367;9958.153556947633;9960.954099819488;9818.607255709763;9909.65316213929;9919.057689519484;9921.851172232422;9924.603015879356;9806.313558050939;9935;9942.70171894837;9957.5021248938;9962.701118966443;40675.59324406777;41220.79389603063;41258.793706031574;41340.58659413397;41392.58607413917;3220.71013608774;3346.1634591352163;3673.522442082539;3730.757500762442;3885.2812229737588;28932.27669308263;29759;30186.245343866358;30346.54480182799;30385;2710.6611673540806;2811.63448751663;2863.3271181272594;2869.1249169003445;2969.2576855786056;465314;471691;471882;471993;472370;63668.04497932535;65137.67431162909;65162.34837651563;65165.02252466217;65184.674076629315;72016;72113;72180;72244.2775572248;72297.6385118071;17195.656086878444;17393.739093913602;17422.738658920127;17425.825741742672;17474.213660385314;13117.868821311855;13200.867991320156;13210.273434960976;13214.207147570984;13218.008649351337;19602.607947840963;21291.893540532506;21519;21563.353099407042;21590.568188636138;7724.382049436032;8885.91114088851;9243.722688319362;9310.53447327631;9472.147506724428;745.3366503811612;991.1377101921374;1012.8835183953793;1060.7030031591166;1103.542030057533;26901.596476052873;27144.592831107548;27267.863660681967;27366.179014629593;27414.17757467279;1100.3837850803575;1100.5267734873921;1142.714321419645;1154.3074155506629;1234.6357824441811;13947.511837085856;14052.437902483991;14120.85879141216;14367.712645747026;14403.78394324086;422021;426412;503768;507397;509914;57013;58651;58816;58817.41182588205;58935.41064589385;1220.6460126563197;1358.660334916271;1448.8481657082646;1466.332818567549;1581.6362236685627;28648;29011.7098829009;29121.70878291275;29606.851965740032;29695;48102.5189748112;48581;48666.75666621786;48695.26957095575;48827.75586122047;298808;348215;362434;362802;363142;27713.168604941882;32041.519377208893;32118.518222227154;32162.35675286528;32643.18392040218;41285.79357103195;41808;41922.37116443195;42195.57804422039;42227.94430139271;33471.330573388885;34497.827510862284;35120.12199695028;35253.47119793154;36697.81651091728;34982.82508587441;35304.11739706528;35406;36101.45847812337;36169.81915090408;35923;35949.82025089858;36564.81717591395;37381.813090934374;37431.81284093562;28421.289467763472;30247;30301.93943211977;30377.24056898595;30437.695623044372;22999.770002300433;23011.769882300963;23465.765342346356;23603.173888913807;23636.645450318603 16:08:13 INFO - PROCESS | 1663 | |2;jquery.html;301.891319125115;353.55099024239234;354.7250880567559;361.1098641847846;364.8139448881073;15300.540983770505;15742.449014284502;17513.29946802128;18544.08581725842;19472.70790938137;19231.423057308268;19299.903500482476;19930.60138797223;19957;19963.20147194114;5771.989901767195;5780.988327042772;5864.325602555718;5967.761289548413;5980.760769569212;3926.5680775114715;4136.296829538986;5918.2898052233795;5929;5979;6221.59559628625;6455.677216139197;6464.676766161697;6468.935310646881;6473.579217350881;5360.383555891083;6364.236291645009;6439.58142720724;6458.063580780784;6458.580192287486;4806.206975848981;5576.302962129734;5594.13290939905;5603.971980140114;5606.355269144019;22781.202657906895;24865.627015594782;25188.088322776883;25255.494890102094;25289.873550632314;2211.8230541556636;2869.6556413230337;2884.8413337266443;2893.6093627360247;3003.6695963444004;14172;14188.92905535476;14294.714105717827;14462.71074578513;14611.926940365336;1523.649560601057;1566.2716836670888;1581.4623028170363;1730.8788384813067;1753.7106377447706;89919;93084;93174;93466.59800103072;93624.53187734087;10196.745081373025;10441.060304572626;10564.313319634199;10571.735706607242;10720.463976801284;11842;12308;12728.490860365482;12748.745025099632;12799.232046077264;8304.916950830535;8427.115152908978;8464.06895241523;8481.15188481147;8628.611712472828;8789.824203515895;8840.33697472692;8855.070217627057;8940.105989401009;8968;6005.759769609167;6105.236845394325;6107.175531303306;6115.021596544531;6116.143739876421;1378.6829029323312;1809.6199798042296;1813.86396020299;1829.4328758085037;1830.880992735468;941.3692825806726;963.7205210488879;994.179801663616;1049.8425236214475;1051.232600201857;17100.91449542744;18150.00174990388;20756.79243207579;21010.36968890936;21084.21485922878;969.3263182088522;975.8731364922514;988.461288597716;988.5551501824065;1012.250934308621;11173.10615150786;11263.87918605171;11308.491117899714;11375.772484550263;11416.257943233662;540050;640105;643904;651700;653248;99660.50169749105;100372;101320.49339753401;101591;105711;1043.5147656339839;1044.1385856668278;1057.1806849691397;1057.9153667706564;1078.9622363217093;18231.90884045571;18424;18492.630147397245;18557.16492757856;18719.625607488048;36839.44740828943;37366.74864192142;45181;47812.52187478081;48391.5160848387;55919;59314.40685593261;59981.10028349491;60213.096803548855;60607.09089363575;7255.274472552703;7270.854582908418;7334.889976650248;7416.25837416254;7614.657340419583;8674.349423793366;10596.788064238826;11668.474918628512;11926.344051076927;12081;9751.003133072967;9972.650957216463;10033.297669163088;10404.11565016982;10525.578976840841;9180.862287065565;9912.653057142965;10239.180865530889;10264.435456049989;10447.216458765775;9888.208943284664;9960.402375857471;10238.18094552449;10247.487625618838;10275.17798576097;7173.210946795953;7202.459815513962;7284.49008569395;7301.014363060919;7513.211112833293;9914.851277230702;9979.750506237402;10209.234307427121;10235.7441063974;10695.358278503314 16:08:13 INFO - PROCESS | 1663 | |3;mootools.html;1440.5678296511057;1609.6780643871225;1629.226117594143;1909.3985394600709;2036.2465887621581;7499.962500187491;7929.524228546291;8554.52950087745;8678.218960293572;8717.782055448617;8382.245597896188;8683.17509836566;8692.695755648554;8697;8707.869381959275;1946.707993800927;2073.1189244570996;2201.9779802202015;2402.1232250228672;2432.1487479382163;2214.1032881682945;2387.2599494156866;2452.1294940296207;2456.1771806444863;2463.285647162321;2367.5146594947996;2405.0620258099357;2418.056957786465;2418.7944024757917;2421.83047186697;2410.650455683925;2414.1188466209883;2414.251582009565;2417.5406672732124;2420.8910599022997;2340.941476463085;2397.041183526586;2397.9520409591887;2405.915792947256;2413.2398294537165;8732.995705493886;8819.647214111428;8822.955885220597;8833.55832208387;8839.46963182211;5275.393329767087;5412.783488660449;5455.863603409907;5457.426970168115;5460.645058071213;3049.8258170604254;3472.9305413891834;3672.8530858765616;3673.485712000322;3674.0447483654175;1040.3237895367995;1056.2025670618634;1062.0759938853248;1069.1446842525947;1074.7957888001254;11896.702582435422;12015.098867584966;12033;12045.457954392074;12046.638600841989;4142.875713728593;4546.772371459688;4745;4828.879278018007;4848.951510484921;8499.66001359951;8537.231649151607;10140.898591014144;10143.847842282372;10153.796924061477;5395.271638328775;5407.567394608422;5412.566994640498;5416.51251387377;5417.322834645669;4356.302991521341;4457.286834106528;4888.535589119028;4930.926036109461;4941.72820494869;3827.5215598050245;3867.0719027433774;3932.744371615836;3936.488256526633;3944.6449819516383;1136.6419577832955;1141.4521029905525;1256.9378874850736;1267.14467734279;1319.0634649399035;1348.4740951029107;1359.320339830085;1383.4120498787975;1409.0488919978973;1413.039133389305;7988.320992715684;8141.470804397695;8143.674253029931;8190.467619604707;8231;1034.374203606822;1201.7536405036947;1217.5008246618843;1218.165556593736;1247.600767754328;6195.349488303754;6207.534434917399;6272.560920735596;6277.52918531112;6299.181106456132;10435.739106522398;10750.139988800876;10822.945885270523;10826.89173108259;10913.508892099715;10458.424786636808;10506.842397364046;10727.463626818628;10797.190210734227;10808.02727754506;8174.632141553644;8293.253607175384;8293.875591866126;8300.460470069425;8314.750557483285;7682.615869206629;7875.409344299086;7889.368850491832;7915.05019397676;7931.5637639930355;9353.11145441182;9401.670941517013;9535.998720134286;9594.992525784692;9724.562394692397;9746;9843.753906152404;9848;9864.013598640078;9996.350237234556;6586.604803711793;7125.18060423058;7448.292412220831;7527.8118047049265;7546.811329716801;8149.429539932148;8155.062167850773;8201.30288925448;8202.794930126794;8235.50586964784;7156.821079473055;7224.8916266255;7247.782566523013;7348.926510735038;7394.260573942563;7141.250168732416;7182.640867956686;7279.599622020628;7302.379297759538;7302.525335853153;6170.81487555374;7614.847703046019;7647.541147531166;7665.42509311815;7666.233376662289;6943.930560694328;6979.930200697928;6980.406665433495;6996.195437524546;6999.30006999296;6688.765893193715;6852.588844669336;6894.931050689429;6904.516683832084;6909.550879192836 16:08:13 INFO - PROCESS | 1663 | |4;prototype.html;321.9517072439134;324.6234368132966;328.2859779978546;330.41681432272037;333.9582552180979;6506.284308726043;6559.508036897228;6588.967055164718;6598.439132673717;6601.768938087168;6409.775657851976;6476.384743449376;6487.286398496173;6489.967550162242;6505.90241146382;4631.073785242948;4701.600363969067;4739.763011849411;4854.320395144674;4861.659683822134;4774.952250477486;4792.928106078394;4796.640251981098;4801.951980480186;4854.87862803431;3885.61143885612;4765.69023013503;4787.329773831666;4821.30091136785;4830.033993201374;4352.064306174188;4527.094581083797;4624.514425985273;4739.123262196505;4770.165221086296;3750.5124333836698;4097.467329247179;4116.094459218967;4116.176764647053;4118.217538667644;6139.26328840542;6163.568550201488;6163.907541386883;6178.5366097542865;6183.628982261033;5660.943390566083;5661;5666.801661941812;5680.943190568124;5702.686352250625;6796;6796.932030679679;6798.184217893835;6802.693878775467;6803.081583986148;4478.104379124188;4671.95328046722;4676.597020893718;4680.134175177569;4689.95310046902;7067.752628657972;7274.818129546804;7291.8906216406795;7304.196538380774;7317.707291708379;4030.7783071931326;4711.81152753886;4766.904661906812;4772.236442169236;4801.207800712913;4825.9034819303415;4836.733979631154;4838.927416088762;4842.58837998767;4853.878653033632;5650.802221922213;5662.971685141548;5667.064934285879;5668.376478587352;5676.943230567724;6710.6481369275;6886.758963436256;6922.376986071277;6934.271901450376;6941.930580694229;1406.69052808382;1660.3396603396604;1670.5322509697305;1687.687777761118;1690.6111594333372;1035.471909326249;1072.8873468285874;1097.544519024596;1106.2919731371928;1130.796456637813;5759.164921086419;5990.820275391745;6298.937010629835;6319.778807741707;6386.872262554816;7250.984862119308;7267.0552828132;7272.600006999666;7277.2722727726805;7282.599457029914;6523.641199733966;6543.051257567721;6543.901841472381;6545.803625891231;6557.639329836905;3753.868614598476;3809.7523660961947;3832.559255685576;3834.9616503835164;3844.6539811417106;7356.970024196617;7635.732749353746;7644.12092609357;7658.195889431529;7679.846403071907;7437.070366204224;7506.587137707369;7528.5859277739155;7544.698212071566;7550.773476795595;6084.847878803065;7579.962100189464;7591.4685971981435;7601.277878601524;7616.885746713804;7042.190148132825;7275.708971641287;7296.744613938699;7298.854022919406;7302.415806735555;7107.538010029331;7158.284171583008;7160.928390716026;7164.713411463483;7185.964070179615;7574.3183113520045;7610.391168706379;7615.7334493292465;7624.123225828879;7626.656800443882;3781.7920014399474;4625.288643202037;4628.67599268048;4638.234691275901;4642.651801114863;6958.756443524452;7234.5659260444545;7237.963810181126;7246.492745507764;7249.130104387296;6971.965140174267;6983.825404364931;6991.021257024123;6998.895016574654;7009.404200643003;6901.275366086488;6958.652067396712;6981.232064472802;6988.40598549129;6999.51003429755;6764.120664313607;6775.62734049632;6780.864382712417;6787.389134977876;6803.795886123424;6694.564853284521;6950.582965022115;6993.895091573529;6997.825054373681;6999.265077166824;6541.803745887631;6681.498887583353;6756.729730810909;6822.761203357859;6839.316068393121 16:08:13 INFO - PROCESS | 1663 | |5;yui.html;659.123365923322;685.3797313431345;756.5914406220642;756.9886451703223;810.8378324335134;15000.324985375657;15199.468018619351;15205.4678086267;15205.847941520582;15227.847721522781;13924.651883702913;13968.93015534921;13988.720225595507;13996.300184990761;14044.157350558948;726.920038795732;738.1695592458484;889.1997202517721;891.9965039330737;905.7645012296784;912.0879120879121;913.8766266553996;916.0381599320687;916.294453270981;917.7338571814166;747.6411322565172;977.9853302200472;978.9755256118583;979.5347210075229;980.206033113177;774.930256276935;943.2878176976408;970.3110791338123;974.2108891797667;974.2741657465234;724.5000949344987;724.768074216251;726.8437285983539;727.2436665867491;727.4907564704675;14642.341094650767;15054.397824087024;15057.54827355181;15061.698766024727;15070;12619.810702839464;12662.55681051168;12832.743345133045;12980.870191298061;13090.738185236241;9872.35829671069;10090.798184036279;10143.340682855665;10412.010858968386;10591.947040264826;3473.2532505511185;3604.6575575320303;3652.4156135018534;3653.7807731535927;3671.118931456458;83842.58078709568;84520.30959380777;85685.71471427934;86693.26613467696;86698;9326.72019839406;9337.673181438753;9495.192908602708;9549.851283461167;9615.56729947154;20416.489587760127;20475.692864607045;20496.18015279402;20499.07754151067;20517.076731547117;7128.358447739728;7277.417806575461;7438.925610743823;7458.552486850806;7587.924120758832;3971.4241434991764;4027.617376349242;4104.8152833122585;4117.835286588563;4118.176364727066;3531.3643544161782;3577.0878426001204;3578.355895938756;3582;3582.7133829294116;651.1437459740426;659.8119535932236;663.2604645819877;663.3697986912356;675.5136301862651;539.8947205295009;575.9539236861041;592.5437413191818;598.3478008970243;618.9597676151036;7866.488678235896;8008.27925486709;8067.152948940394;8280.130586288473;8326.70856520031;584.3105135939632;598.9760409583655;603.8218725475907;611.1413464082971;633.7021599848064;3725.4225595032813;3754.4743735877;3791.658750712449;3832.2718683450057;3861.2663593917064;78867;80256.79614805782;80359;80368.79446808303;80456.59771701104;80328.598357009;82469.17530824734;82850.58574707087;83430;83588;69807;70730;71083;71716.64141679363;71928.64035679789;7670.8082297943;7768.650410731418;7770;7841.09827369837;7853.625191475837;49459.258111127645;51668.74165629148;51681.224781627556;52775.20837187368;52859.471405285454;67379;69747;70977;71816;72985.27014729785;9810.460424676712;9906.25703072258;11363.318200907972;11433.59982400612;11450.427478625868;11805.291682499077;12072.879271207526;12252.816207756712;12563.434645440795;12684.746305073662;11476.196666233283;11855.76288474243;11884.34636095023;11964.401779911144;12134.929616614096;9367.344285899922;11331.716707082389;11425.485853136795;11681.240719353214;11843.526258949545;11412.828807567726;11664.183507154758;11742.765144697229;11777.705557360792;12364.19632723906;9565.617375305188;9628;9635.855462167932;9641.566129524048;9860.654877079267;7645.599080976672;8922.73231803047;9222.95388523053;9621.615135394506;9659.565319560495 16:08:13 INFO - PROCESS | 1663 | __end_tp_report 16:08:13 INFO - PROCESS | 1663 | __start_cc_report 16:08:13 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1055 16:08:13 INFO - PROCESS | 1663 | __end_cc_report 16:08:13 INFO - PROCESS | 1663 | __startTimestamp1458256093929__endTimestamp 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:08:13 INFO - PROCESS | 1663 | Number of tests: 6 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5622.33 Median:5845.85 stddev:652.29 (11.2%) stddev-sans-first:621.43 16:08:13 INFO - PROCESS | 1663 | Values: 3016.3 3370.7 3456.3 3496.8 3515.8 5446.7 5535.5 5608.7 5615.5 5617.9 5613.1 5632.2 5661.8 5736.5 5772.7 5045.8 5073.2 5095.6 5105.9 5206.0 5102.8 5185.7 5233.1 5239.2 5271.6 4252.8 5010.0 5084.6 5120.1 5148.0 5117.9 5134.3 5134.8 5137.9 5166.7 5058.7 5116.2 5126.5 5127.1 5135.3 5446.2 5537.4 5543.9 5553.1 5573.7 6066.8 6068.6 6071.3 6075.7 6087.0 5206.7 6118.4 6125.5 6137.3 6144.7 4696.0 5655.9 5676.7 5678.8 5684.3 5190.1 6175.9 6205.8 6259.2 6287.8 6040.2 6049.2 6058.3 6065.0 6077.5 6181.0 6190.5 6192.1 6196.4 6198.9 5949.5 6034.5 6059.9 6062.9 6069.3 6021.9 6044.8 6050.0 6064.2 6102.8 4798.4 4825.3 4835.9 4837.4 4841.4 3491.6 4272.6 4308.1 4363.3 4408.4 5569.8 5575.0 5580.4 5594.8 5643.5 6011.7 6064.6 6151.2 6166.5 6184.2 5545.6 5584.4 5605.7 5607.3 5652.2 5241.9 5274.1 5300.7 5310.8 5322.5 6197.3 6239.9 6241.8 6243.7 6256.3 6122.6 6170.2 6233.9 6237.3 6257.5 6219.0 6226.3 6228.2 6238.1 6279.6 5979.9 6077.7 6082.8 6094.7 6107.5 6134.1 6177.3 6189.3 6207.9 6211.0 5003.4 5845.9 5998.0 6037.6 6052.5 5845.7 5957.6 6002.7 6022.9 6051.8 5858.1 5859.6 5869.6 5870.2 5920.9 6046.6 6062.7 6063.5 6064.3 6067.6 5714.7 5809.3 5814.9 5855.9 5863.6 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:58697.01 Median:37406.81 stddev:115457.30 (308.7%) stddev-sans-first:115698.48 16:08:13 INFO - PROCESS | 1663 | Values: 491.6 576.2 579.5 631.9 636.0 38312.6 39120.0 39144.4 39183.8 39194.0 41777.6 42379.8 42398.8 42462.8 42501.6 9654.9 9875.4 9891.9 9894.3 9907.5 9744.9 9903.0 9904.8 9905.0 9920.5 9861.8 9891.2 9936.9 9958.2 9961.0 9818.6 9909.7 9919.1 9921.9 9924.6 9806.3 9935.0 9942.7 9957.5 9962.7 40675.6 41220.8 41258.8 41340.6 41392.6 3220.7 3346.2 3673.5 3730.8 3885.3 28932.3 29759.0 30186.2 30346.5 30385.0 2710.7 2811.6 2863.3 2869.1 2969.3 465314.0 471691.0 471882.0 471993.0 472370.0 63668.0 65137.7 65162.3 65165.0 65184.7 72016.0 72113.0 72180.0 72244.3 72297.6 17195.7 17393.7 17422.7 17425.8 17474.2 13117.9 13200.9 13210.3 13214.2 13218.0 19602.6 21291.9 21519.0 21563.4 21590.6 7724.4 8885.9 9243.7 9310.5 9472.1 745.3 991.1 1012.9 1060.7 1103.5 26901.6 27144.6 27267.9 27366.2 27414.2 1100.4 1100.5 1142.7 1154.3 1234.6 13947.5 14052.4 14120.9 14367.7 14403.8 422021.0 426412.0 503768.0 507397.0 509914.0 57013.0 58651.0 58816.0 58817.4 58935.4 1220.6 1358.7 1448.8 1466.3 1581.6 28648.0 29011.7 29121.7 29606.9 29695.0 48102.5 48581.0 48666.8 48695.3 48827.8 298808.0 348215.0 362434.0 362802.0 363142.0 27713.2 32041.5 32118.5 32162.4 32643.2 41285.8 41808.0 41922.4 42195.6 42227.9 33471.3 34497.8 35120.1 35253.5 36697.8 34982.8 35304.1 35406.0 36101.5 36169.8 35923.0 35949.8 36564.8 37381.8 37431.8 28421.3 30247.0 30301.9 30377.2 30437.7 22999.8 23011.8 23465.8 23603.2 23636.6 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:33309.37 Median:357.92 stddev:103233.33 (28842.8%) stddev-sans-first:103493.17 16:08:13 INFO - PROCESS | 1663 | Values: 301.9 353.6 354.7 361.1 364.8 15300.5 15742.4 17513.3 18544.1 19472.7 19231.4 19299.9 19930.6 19957.0 19963.2 5772.0 5781.0 5864.3 5967.8 5980.8 3926.6 4136.3 5918.3 5929.0 5979.0 6221.6 6455.7 6464.7 6468.9 6473.6 5360.4 6364.2 6439.6 6458.1 6458.6 4806.2 5576.3 5594.1 5604.0 5606.4 22781.2 24865.6 25188.1 25255.5 25289.9 2211.8 2869.7 2884.8 2893.6 3003.7 14172.0 14188.9 14294.7 14462.7 14611.9 1523.6 1566.3 1581.5 1730.9 1753.7 89919.0 93084.0 93174.0 93466.6 93624.5 10196.7 10441.1 10564.3 10571.7 10720.5 11842.0 12308.0 12728.5 12748.7 12799.2 8304.9 8427.1 8464.1 8481.2 8628.6 8789.8 8840.3 8855.1 8940.1 8968.0 6005.8 6105.2 6107.2 6115.0 6116.1 1378.7 1809.6 1813.9 1829.4 1830.9 941.4 963.7 994.2 1049.8 1051.2 17100.9 18150.0 20756.8 21010.4 21084.2 969.3 975.9 988.5 988.6 1012.3 11173.1 11263.9 11308.5 11375.8 11416.3 540050.0 640105.0 643904.0 651700.0 653248.0 99660.5 100372.0 101320.5 101591.0 105711.0 1043.5 1044.1 1057.2 1057.9 1079.0 18231.9 18424.0 18492.6 18557.2 18719.6 36839.4 37366.7 45181.0 47812.5 48391.5 55919.0 59314.4 59981.1 60213.1 60607.1 7255.3 7270.9 7334.9 7416.3 7614.7 8674.3 10596.8 11668.5 11926.3 12081.0 9751.0 9972.7 10033.3 10404.1 10525.6 9180.9 9912.7 10239.2 10264.4 10447.2 9888.2 9960.4 10238.2 10247.5 10275.2 7173.2 7202.5 7284.5 7301.0 7513.2 9914.9 9979.8 10209.2 10235.7 10695.4 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5989.87 Median:5410.07 stddev:3166.48 (58.5%) stddev-sans-first:3156.90 16:08:13 INFO - PROCESS | 1663 | Values: 1440.6 1609.7 1629.2 1909.4 2036.2 7500.0 7929.5 8554.5 8678.2 8717.8 8382.2 8683.2 8692.7 8697.0 8707.9 1946.7 2073.1 2202.0 2402.1 2432.1 2214.1 2387.3 2452.1 2456.2 2463.3 2367.5 2405.1 2418.1 2418.8 2421.8 2410.7 2414.1 2414.3 2417.5 2420.9 2340.9 2397.0 2398.0 2405.9 2413.2 8733.0 8819.6 8823.0 8833.6 8839.5 5275.4 5412.8 5455.9 5457.4 5460.6 3049.8 3472.9 3672.9 3673.5 3674.0 1040.3 1056.2 1062.1 1069.1 1074.8 11896.7 12015.1 12033.0 12045.5 12046.6 4142.9 4546.8 4745.0 4828.9 4849.0 8499.7 8537.2 10140.9 10143.8 10153.8 5395.3 5407.6 5412.6 5416.5 5417.3 4356.3 4457.3 4888.5 4930.9 4941.7 3827.5 3867.1 3932.7 3936.5 3944.6 1136.6 1141.5 1256.9 1267.1 1319.1 1348.5 1359.3 1383.4 1409.0 1413.0 7988.3 8141.5 8143.7 8190.5 8231.0 1034.4 1201.8 1217.5 1218.2 1247.6 6195.3 6207.5 6272.6 6277.5 6299.2 10435.7 10750.1 10822.9 10826.9 10913.5 10458.4 10506.8 10727.5 10797.2 10808.0 8174.6 8293.3 8293.9 8300.5 8314.8 7682.6 7875.4 7889.4 7915.1 7931.6 9353.1 9401.7 9536.0 9595.0 9724.6 9746.0 9843.8 9848.0 9864.0 9996.4 6586.6 7125.2 7448.3 7527.8 7546.8 8149.4 8155.1 8201.3 8202.8 8235.5 7156.8 7224.9 7247.8 7348.9 7394.3 7141.3 7182.6 7279.6 7302.4 7302.5 6170.8 7614.8 7647.5 7665.4 7666.2 6943.9 6979.9 6980.4 6996.2 6999.3 6688.8 6852.6 6894.9 6904.5 6909.6 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5713.13 Median:6506.09 stddev:1825.85 (28.1%) stddev-sans-first:1785.57 16:08:13 INFO - PROCESS | 1663 | Values: 322.0 324.6 328.3 330.4 334.0 6506.3 6559.5 6589.0 6598.4 6601.8 6409.8 6476.4 6487.3 6490.0 6505.9 4631.1 4701.6 4739.8 4854.3 4861.7 4775.0 4792.9 4796.6 4802.0 4854.9 3885.6 4765.7 4787.3 4821.3 4830.0 4352.1 4527.1 4624.5 4739.1 4770.2 3750.5 4097.5 4116.1 4116.2 4118.2 6139.3 6163.6 6163.9 6178.5 6183.6 5660.9 5661.0 5666.8 5680.9 5702.7 6796.0 6796.9 6798.2 6802.7 6803.1 4478.1 4672.0 4676.6 4680.1 4690.0 7067.8 7274.8 7291.9 7304.2 7317.7 4030.8 4711.8 4766.9 4772.2 4801.2 4825.9 4836.7 4838.9 4842.6 4853.9 5650.8 5663.0 5667.1 5668.4 5676.9 6710.6 6886.8 6922.4 6934.3 6941.9 1406.7 1660.3 1670.5 1687.7 1690.6 1035.5 1072.9 1097.5 1106.3 1130.8 5759.2 5990.8 6298.9 6319.8 6386.9 7251.0 7267.1 7272.6 7277.3 7282.6 6523.6 6543.1 6543.9 6545.8 6557.6 3753.9 3809.8 3832.6 3835.0 3844.7 7357.0 7635.7 7644.1 7658.2 7679.8 7437.1 7506.6 7528.6 7544.7 7550.8 6084.8 7580.0 7591.5 7601.3 7616.9 7042.2 7275.7 7296.7 7298.9 7302.4 7107.5 7158.3 7160.9 7164.7 7186.0 7574.3 7610.4 7615.7 7624.1 7626.7 3781.8 4625.3 4628.7 4638.2 4642.7 6958.8 7234.6 7238.0 7246.5 7249.1 6972.0 6983.8 6991.0 6998.9 7009.4 6901.3 6958.7 6981.2 6988.4 6999.5 6764.1 6775.6 6780.9 6787.4 6803.8 6694.6 6950.6 6993.9 6997.8 6999.3 6541.8 6681.5 6756.7 6822.8 6839.3 16:08:13 INFO - PROCESS | 1663 | 16:08:13 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18341.84 Median:34021.18 stddev:25701.62 (75.5%) stddev-sans-first:25739.42 16:08:13 INFO - PROCESS | 1663 | Values: 659.1 685.4 756.6 757.0 810.8 15000.3 15199.5 15205.5 15205.8 15227.8 13924.7 13968.9 13988.7 13996.3 14044.2 726.9 738.2 889.2 892.0 905.8 912.1 913.9 916.0 916.3 917.7 747.6 978.0 979.0 979.5 980.2 774.9 943.3 970.3 974.2 974.3 724.5 724.8 726.8 727.2 727.5 14642.3 15054.4 15057.5 15061.7 15070.0 12619.8 12662.6 12832.7 12980.9 13090.7 9872.4 10090.8 10143.3 10412.0 10591.9 3473.3 3604.7 3652.4 3653.8 3671.1 83842.6 84520.3 85685.7 86693.3 86698.0 9326.7 9337.7 9495.2 9549.9 9615.6 20416.5 20475.7 20496.2 20499.1 20517.1 7128.4 7277.4 7438.9 7458.6 7587.9 3971.4 4027.6 4104.8 4117.8 4118.2 3531.4 3577.1 3578.4 3582.0 3582.7 651.1 659.8 663.3 663.4 675.5 539.9 576.0 592.5 598.3 619.0 7866.5 8008.3 8067.2 8280.1 8326.7 584.3 599.0 603.8 611.1 633.7 3725.4 3754.5 3791.7 3832.3 3861.3 78867.0 80256.8 80359.0 80368.8 80456.6 80328.6 82469.2 82850.6 83430.0 83588.0 69807.0 70730.0 71083.0 71716.6 71928.6 7670.8 7768.7 7770.0 7841.1 7853.6 49459.3 51668.7 51681.2 52775.2 52859.5 67379.0 69747.0 70977.0 71816.0 72985.3 9810.5 9906.3 11363.3 11433.6 11450.4 11805.3 12072.9 12252.8 12563.4 12684.7 11476.2 11855.8 11884.3 11964.4 12134.9 9367.3 11331.7 11425.5 11681.2 11843.5 11412.8 11664.2 11742.8 11777.7 12364.2 9565.6 9628.0 9635.9 9641.6 9860.7 7645.6 8922.7 9223.0 9621.6 9659.6 16:08:13 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:08:13 INFO - PROCESS | 1663 | 16:08:14 INFO - TEST-INFO | 1663: exit 0 16:08:14 INFO - TEST-OK | dromaeo_css | took 1113436ms 16:08:14 INFO - TEST-START | kraken 16:08:14 INFO - operating with platform_type : mac_ 16:08:14 INFO - Initialising browser for kraken test... 16:08:14 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpzxqMhr/profile http://localhost:49270/getInfo.html) 16:08:16 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 16:08:16 INFO - PROCESS | 1672 | colorDepth:24 16:08:16 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 16:08:16 INFO - PROCESS | 1672 | __metrics 16:08:16 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" 16:08:16 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:08:17 INFO - TEST-INFO | 1672: exit 0 16:08:17 INFO - Browser initialized. 16:08:17 INFO - Running cycle 1/1 for kraken test... 16:08:17 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpzxqMhr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:29 INFO - PROCESS | 1674 | RSS: Main: 243908608 16:08:29 INFO - PROCESS | 1674 | 16:08:31 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:32 INFO - PROCESS | 1674 | RSS: Main: 290111488 16:08:32 INFO - PROCESS | 1674 | 16:08:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:08:35 INFO - PROCESS | 1674 | RSS: Main: 300007424 16:08:35 INFO - PROCESS | 1674 | 16:08:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:08:39 INFO - PROCESS | 1674 | RSS: Main: 286777344 16:08:39 INFO - PROCESS | 1674 | 16:08:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:08:42 INFO - PROCESS | 1674 | RSS: Main: 290021376 16:08:42 INFO - PROCESS | 1674 | 16:08:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:45 INFO - PROCESS | 1674 | RSS: Main: 291422208 16:08:45 INFO - PROCESS | 1674 | 16:08:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:48 INFO - PROCESS | 1674 | RSS: Main: 291999744 16:08:48 INFO - PROCESS | 1674 | 16:08:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:51 INFO - PROCESS | 1674 | RSS: Main: 290553856 16:08:51 INFO - PROCESS | 1674 | 16:08:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:08:55 INFO - PROCESS | 1674 | RSS: Main: 291004416 16:08:55 INFO - PROCESS | 1674 | 16:08:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:57 INFO - PROCESS | 1674 | RSS: Main: 325816320 16:08:57 INFO - PROCESS | 1674 | 16:08:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:59 INFO - PROCESS | 1674 | RSS: Main: 325001216 16:08:59 INFO - PROCESS | 1674 | 16:09:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:02 INFO - PROCESS | 1674 | RSS: Main: 332615680 16:09:02 INFO - PROCESS | 1674 | 16:09:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:05 INFO - PROCESS | 1674 | RSS: Main: 333127680 16:09:05 INFO - PROCESS | 1674 | 16:09:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:08 INFO - PROCESS | 1674 | RSS: Main: 333156352 16:09:08 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:09:10 INFO - PROCESS | 1674 | RSS: Main: 394387456 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | __start_tp_report 16:09:10 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 16:09:10 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 16:09:10 INFO - PROCESS | 1674 | |i|pagename|runs| 16:09:10 INFO - PROCESS | 1674 | |0;ai-astar;114;108;110;110;112;111;116;110;109;113 16:09:10 INFO - PROCESS | 1674 | |1;audio-beat-detection;154;124;141;156;117;141;138;141;176;116 16:09:10 INFO - PROCESS | 1674 | |2;audio-dft;183;184;185;186;186;186;221;260;183;184 16:09:10 INFO - PROCESS | 1674 | |3;audio-fft;80;74;83;75;57;77;85;81;77;55 16:09:10 INFO - PROCESS | 1674 | |4;audio-oscillator;77;95;165;119;78;82;115;78;105;154 16:09:10 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;89;86;89;87;89;85;90;87;89;86 16:09:10 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;94;94;94;94;94;94;94;93;94 16:09:10 INFO - PROCESS | 1674 | |7;imaging-desaturate;87;87;87;86;86;85;84;95;132;139 16:09:10 INFO - PROCESS | 1674 | |8;json-parse-financial;56;54;53;52;54;53;55;65;57;54 16:09:10 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;62;69;78;75;71;67;65;66;65 16:09:10 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;83;83;83;81;80;84;82;83;84 16:09:10 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;136;132;142;126;120;118;123;122;121;121 16:09:10 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;127;126;137;138;137;122;140;137;137;138 16:09:10 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;65;67;67;67;67;67;68;68;67;67 16:09:10 INFO - PROCESS | 1674 | __end_tp_report 16:09:10 INFO - PROCESS | 1674 | __start_cc_report 16:09:10 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1263 16:09:10 INFO - PROCESS | 1674 | __end_cc_report 16:09:10 INFO - PROCESS | 1674 | __startTimestamp1458256150599__endTimestamp 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | ------- Summary: start ------- 16:09:10 INFO - PROCESS | 1674 | Number of tests: 14 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:2.45 (2.2%) stddev-sans-first:2.40 16:09:10 INFO - PROCESS | 1674 | Values: 114.0 108.0 110.0 110.0 112.0 111.0 116.0 110.0 109.0 113.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:141.00 stddev:18.60 (13.2%) stddev-sans-first:19.07 16:09:10 INFO - PROCESS | 1674 | Values: 154.0 124.0 141.0 156.0 117.0 141.0 138.0 141.0 176.0 116.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:195.80 Median:186.00 stddev:25.31 (13.6%) stddev-sans-first:26.42 16:09:10 INFO - PROCESS | 1674 | Values: 183.0 184.0 185.0 186.0 186.0 186.0 221.0 260.0 183.0 184.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:74.40 Median:78.50 stddev:10.30 (13.1%) stddev-sans-first:10.72 16:09:10 INFO - PROCESS | 1674 | Values: 80.0 74.0 83.0 75.0 57.0 77.0 85.0 81.0 77.0 55.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:77.50 stddev:31.86 (41.1%) stddev-sans-first:31.92 16:09:10 INFO - PROCESS | 1674 | Values: 77.0 95.0 165.0 119.0 78.0 82.0 115.0 78.0 105.0 154.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.70 (1.9%) stddev-sans-first:1.74 16:09:10 INFO - PROCESS | 1674 | Values: 89.0 86.0 89.0 87.0 89.0 85.0 90.0 87.0 89.0 86.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:09:10 INFO - PROCESS | 1674 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:86.50 stddev:20.68 (23.9%) stddev-sans-first:21.62 16:09:10 INFO - PROCESS | 1674 | Values: 87.0 87.0 87.0 86.0 86.0 85.0 84.0 95.0 132.0 139.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.50 stddev:3.71 (6.8%) stddev-sans-first:3.93 16:09:10 INFO - PROCESS | 1674 | Values: 56.0 54.0 53.0 52.0 54.0 53.0 55.0 65.0 57.0 54.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:5.20 (7.6%) stddev-sans-first:5.17 16:09:10 INFO - PROCESS | 1674 | Values: 63.0 62.0 69.0 78.0 75.0 71.0 67.0 65.0 66.0 65.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.33 16:09:10 INFO - PROCESS | 1674 | Values: 84.0 83.0 83.0 83.0 81.0 80.0 84.0 82.0 83.0 84.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:124.50 stddev:7.94 (6.4%) stddev-sans-first:7.57 16:09:10 INFO - PROCESS | 1674 | Values: 136.0 132.0 142.0 126.0 120.0 118.0 123.0 122.0 121.0 121.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.90 Median:137.00 stddev:6.33 (4.6%) stddev-sans-first:6.20 16:09:10 INFO - PROCESS | 1674 | Values: 127.0 126.0 137.0 138.0 137.0 122.0 140.0 137.0 137.0 138.0 16:09:10 INFO - PROCESS | 1674 | 16:09:10 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.44 16:09:10 INFO - PROCESS | 1674 | Values: 65.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 16:09:10 INFO - PROCESS | 1674 | -------- Summary: end -------- 16:09:10 INFO - PROCESS | 1674 | 16:09:11 INFO - TEST-INFO | 1674: exit 0 16:09:11 INFO - TEST-OK | kraken | took 56838ms 16:09:11 INFO - SUITE-END | took 1170s 16:09:11 INFO - Completed test suite (00:19:30) 16:09:11 INFO - javascript benchmark 16:09:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3016.2760937375024, 3370.6797854203846, 3456.2741824216914, 3496.842642081106, 3515.8417871195784, 5446.673199608016, 5535.501804837564, 5608.663480191186, 5615.522680572151, 5617.915731264029, 5613.07384281594, 5632.155176723493, 5661.830145095643, 5736.541076713864, 5772.682502462363, 5045.823396181135, 5073.188289873612, 5095.566876815476, 5105.923411148836, 5205.973970130144, 5102.795888164487, 5185.688858668473, 5233.110371236899, 5239.187925871496, 5271.5782737381105, 4252.787360631972, 5010.048090862724, 5084.644074914758, 5120.052790233819, 5148.047611191922, 5117.948820511821, 5134.306868572732, 5134.845954621367, 5137.871553211162, 5166.715830629314, 5058.721770302632, 5116.155834287375, 5126.461721519224, 5127.077126117298, 5135.255387968724, 5446.2375267462585, 5537.390887002426, 5543.8891222175735, 5553.111502159635, 5573.693446860421, 6066.848328791772, 6068.6358818471035, 6071.2714474263375, 6075.696215189223, 6086.995645718451, 5206.713630750307, 6118.418750218722, 6125.540584456184, 6137.285055221596, 6144.662043587601, 4695.976520117378, 5655.886882262373, 5676.659400435987, 5678.801241956553, 5684.289463816982, 5190.134373214803, 6175.938240617536, 6205.782797602153, 6259.1550140730415, 6287.811365659038, 6040.184575082396, 6049.213602231682, 6058.333583305833, 6065.029595264825, 6077.483413909778, 6180.969095154495, 6190.535709821781, 6192.071189321638, 6196.442320191204, 6198.876022479615, 5949.494292985145, 6034.547408944347, 6059.878802424015, 6062.878742425215, 6069.332373438918, 6021.939780602225, 6044.7582096716515, 6049.969750151309, 6064.151018857364, 6102.786402475892, 4798.424189097261, 4825.252085926687, 4835.879103022453, 4837.395325584302, 4841.370621819211, 3491.5984661763714, 4272.594103560157, 4308.073764140725, 4363.301871700576, 4408.404865343202, 5569.805056822992, 5575.024370735106, 5580.414056524007, 5594.804181853697, 5643.463870932337, 6011.699415029231, 6064.605800622945, 6151.169592105098, 6166.4758495527485, 6184.196054512884, 5545.611807173459, 5584.413636568183, 5605.7197140142825, 5607.271054762937, 5652.18043383707, 5241.947580524222, 5274.077036518594, 5300.70846103468, 5310.787568497294, 5322.494363035506, 6197.349278325892, 6239.937600624117, 6241.843953901189, 6243.687815609202, 6256.280527739368, 6122.581127188433, 6170.228721409824, 6233.875322493615, 6237.313895471404, 6257.530685198537, 6219.0, 6226.283977342482, 6228.190335256388, 6238.095476155841, 6279.591826531261, 5979.880402391841, 6077.6961151943115, 6082.756689732361, 6094.695265236632, 6107.450329470369, 6134.079888016655, 6177.320494745484, 6189.257289125334, 6207.937920620917, 6211.0, 5003.399592048831, 5845.853853653693, 5998.0, 6037.607555508878, 6052.455279024909, 5845.678487683218, 5957.553183511167, 6002.7298771554515, 6022.879542409215, 6051.7579296827635, 5858.062709966555, 5859.648421094748, 5869.618474799125, 5870.207521984648, 5920.911186332122, 6046.5767396281835, 6062.727177277121, 6063.514918806397, 6064.332923378337, 6067.635941843503, 5714.685692286964, 5809.2738407699035, 5814.94185058144, 5855.94144058554, 5863.648181109147], "unit": "score", "name": "dojo.html", "value": 5580.977311133459}, {"lowerIsBetter": false, "replicates": [491.61162681481585, 576.187575518519, 579.4842590094817, 631.9194177955695, 635.9650219237941, 38312.616873831255, 39119.99999999996, 39144.412833807444, 39183.80408097963, 39194.0, 41777.58222417782, 42379.78810105953, 42398.78800606, 42462.7876860616, 42501.57498425015, 9654.903450965507, 9875.407475551454, 9891.851622225673, 9894.307398482073, 9907.504624768733, 9744.902550974506, 9902.950485247564, 9904.752381190492, 9904.950475247613, 9920.503974801268, 9861.802763944717, 9891.208703303719, 9936.90063099367, 9958.153556947633, 9960.954099819488, 9818.607255709763, 9909.65316213929, 9919.057689519484, 9921.851172232422, 9924.603015879356, 9806.313558050939, 9935.0, 9942.70171894837, 9957.5021248938, 9962.701118966443, 40675.59324406777, 41220.79389603063, 41258.793706031574, 41340.58659413397, 41392.58607413917, 3220.71013608774, 3346.1634591352163, 3673.522442082539, 3730.757500762442, 3885.2812229737588, 28932.27669308263, 29759.0, 30186.245343866358, 30346.54480182799, 30385.0, 2710.6611673540806, 2811.63448751663, 2863.3271181272594, 2869.1249169003445, 2969.2576855786056, 465314.0, 471691.0, 471882.0, 471993.0, 472370.0, 63668.04497932535, 65137.67431162909, 65162.34837651563, 65165.02252466217, 65184.674076629315, 72016.0, 72113.0, 72180.0, 72244.2775572248, 72297.6385118071, 17195.656086878444, 17393.739093913602, 17422.738658920127, 17425.825741742672, 17474.213660385314, 13117.868821311855, 13200.867991320156, 13210.273434960976, 13214.207147570984, 13218.008649351337, 19602.607947840963, 21291.893540532506, 21519.0, 21563.353099407042, 21590.568188636138, 7724.382049436032, 8885.91114088851, 9243.722688319362, 9310.53447327631, 9472.147506724428, 745.3366503811612, 991.1377101921374, 1012.8835183953793, 1060.7030031591166, 1103.542030057533, 26901.596476052873, 27144.592831107548, 27267.863660681967, 27366.179014629593, 27414.17757467279, 1100.3837850803575, 1100.5267734873921, 1142.714321419645, 1154.3074155506629, 1234.6357824441811, 13947.511837085856, 14052.437902483991, 14120.85879141216, 14367.712645747026, 14403.78394324086, 422021.0, 426412.0, 503768.0, 507397.0, 509914.0, 57013.0, 58651.0, 58816.0, 58817.41182588205, 58935.41064589385, 1220.6460126563197, 1358.660334916271, 1448.8481657082646, 1466.332818567549, 1581.6362236685627, 28648.0, 29011.7098829009, 29121.70878291275, 29606.851965740032, 29695.0, 48102.5189748112, 48581.0, 48666.75666621786, 48695.26957095575, 48827.75586122047, 298808.0, 348215.0, 362434.0, 362802.0, 363142.0, 27713.168604941882, 32041.519377208893, 32118.518222227154, 32162.35675286528, 32643.18392040218, 41285.79357103195, 41808.0, 41922.37116443195, 42195.57804422039, 42227.94430139271, 33471.330573388885, 34497.827510862284, 35120.12199695028, 35253.47119793154, 36697.81651091728, 34982.82508587441, 35304.11739706528, 35406.0, 36101.45847812337, 36169.81915090408, 35923.0, 35949.82025089858, 36564.81717591395, 37381.813090934374, 37431.81284093562, 28421.289467763472, 30247.0, 30301.93943211977, 30377.24056898595, 30437.695623044372, 22999.770002300433, 23011.769882300963, 23465.765342346356, 23603.173888913807, 23636.645450318603], "unit": "score", "name": "ext.html", "value": 19679.126277513416}, {"lowerIsBetter": false, "replicates": [301.891319125115, 353.55099024239234, 354.7250880567559, 361.1098641847846, 364.8139448881073, 15300.540983770505, 15742.449014284502, 17513.29946802128, 18544.08581725842, 19472.70790938137, 19231.423057308268, 19299.903500482476, 19930.60138797223, 19957.0, 19963.20147194114, 5771.989901767195, 5780.988327042772, 5864.325602555718, 5967.761289548413, 5980.760769569212, 3926.5680775114715, 4136.296829538986, 5918.2898052233795, 5929.0, 5979.0, 6221.59559628625, 6455.677216139197, 6464.676766161697, 6468.935310646881, 6473.579217350881, 5360.383555891083, 6364.236291645009, 6439.58142720724, 6458.063580780784, 6458.580192287486, 4806.206975848981, 5576.302962129734, 5594.13290939905, 5603.971980140114, 5606.355269144019, 22781.202657906895, 24865.627015594782, 25188.088322776883, 25255.494890102094, 25289.873550632314, 2211.8230541556636, 2869.6556413230337, 2884.8413337266443, 2893.6093627360247, 3003.6695963444004, 14172.0, 14188.92905535476, 14294.714105717827, 14462.71074578513, 14611.926940365336, 1523.649560601057, 1566.2716836670888, 1581.4623028170363, 1730.8788384813067, 1753.7106377447706, 89919.0, 93084.0, 93174.0, 93466.59800103072, 93624.53187734087, 10196.745081373025, 10441.060304572626, 10564.313319634199, 10571.735706607242, 10720.463976801284, 11842.0, 12308.0, 12728.490860365482, 12748.745025099632, 12799.232046077264, 8304.916950830535, 8427.115152908978, 8464.06895241523, 8481.15188481147, 8628.611712472828, 8789.824203515895, 8840.33697472692, 8855.070217627057, 8940.105989401009, 8968.0, 6005.759769609167, 6105.236845394325, 6107.175531303306, 6115.021596544531, 6116.143739876421, 1378.6829029323312, 1809.6199798042296, 1813.86396020299, 1829.4328758085037, 1830.880992735468, 941.3692825806726, 963.7205210488879, 994.179801663616, 1049.8425236214475, 1051.232600201857, 17100.91449542744, 18150.00174990388, 20756.79243207579, 21010.36968890936, 21084.21485922878, 969.3263182088522, 975.8731364922514, 988.461288597716, 988.5551501824065, 1012.250934308621, 11173.10615150786, 11263.87918605171, 11308.491117899714, 11375.772484550263, 11416.257943233662, 540050.0, 640105.0, 643904.0, 651700.0, 653248.0, 99660.50169749105, 100372.0, 101320.49339753401, 101591.0, 105711.0, 1043.5147656339839, 1044.1385856668278, 1057.1806849691397, 1057.9153667706564, 1078.9622363217093, 18231.90884045571, 18424.0, 18492.630147397245, 18557.16492757856, 18719.625607488048, 36839.44740828943, 37366.74864192142, 45181.0, 47812.52187478081, 48391.5160848387, 55919.0, 59314.40685593261, 59981.10028349491, 60213.096803548855, 60607.09089363575, 7255.274472552703, 7270.854582908418, 7334.889976650248, 7416.25837416254, 7614.657340419583, 8674.349423793366, 10596.788064238826, 11668.474918628512, 11926.344051076927, 12081.0, 9751.003133072967, 9972.650957216463, 10033.297669163088, 10404.11565016982, 10525.578976840841, 9180.862287065565, 9912.653057142965, 10239.180865530889, 10264.435456049989, 10447.216458765775, 9888.208943284664, 9960.402375857471, 10238.18094552449, 10247.487625618838, 10275.17798576097, 7173.210946795953, 7202.459815513962, 7284.49008569395, 7301.014363060919, 7513.211112833293, 9914.851277230702, 9979.750506237402, 10209.234307427121, 10235.7441063974, 10695.358278503314], "unit": "score", "name": "jquery.html", "value": 9212.221245625424}, {"lowerIsBetter": false, "replicates": [1440.5678296511057, 1609.6780643871225, 1629.226117594143, 1909.3985394600709, 2036.2465887621581, 7499.962500187491, 7929.524228546291, 8554.52950087745, 8678.218960293572, 8717.782055448617, 8382.245597896188, 8683.17509836566, 8692.695755648554, 8697.0, 8707.869381959275, 1946.707993800927, 2073.1189244570996, 2201.9779802202015, 2402.1232250228672, 2432.1487479382163, 2214.1032881682945, 2387.2599494156866, 2452.1294940296207, 2456.1771806444863, 2463.285647162321, 2367.5146594947996, 2405.0620258099357, 2418.056957786465, 2418.7944024757917, 2421.83047186697, 2410.650455683925, 2414.1188466209883, 2414.251582009565, 2417.5406672732124, 2420.8910599022997, 2340.941476463085, 2397.041183526586, 2397.9520409591887, 2405.915792947256, 2413.2398294537165, 8732.995705493886, 8819.647214111428, 8822.955885220597, 8833.55832208387, 8839.46963182211, 5275.393329767087, 5412.783488660449, 5455.863603409907, 5457.426970168115, 5460.645058071213, 3049.8258170604254, 3472.9305413891834, 3672.8530858765616, 3673.485712000322, 3674.0447483654175, 1040.3237895367995, 1056.2025670618634, 1062.0759938853248, 1069.1446842525947, 1074.7957888001254, 11896.702582435422, 12015.098867584966, 12033.0, 12045.457954392074, 12046.638600841989, 4142.875713728593, 4546.772371459688, 4745.0, 4828.879278018007, 4848.951510484921, 8499.66001359951, 8537.231649151607, 10140.898591014144, 10143.847842282372, 10153.796924061477, 5395.271638328775, 5407.567394608422, 5412.566994640498, 5416.51251387377, 5417.322834645669, 4356.302991521341, 4457.286834106528, 4888.535589119028, 4930.926036109461, 4941.72820494869, 3827.5215598050245, 3867.0719027433774, 3932.744371615836, 3936.488256526633, 3944.6449819516383, 1136.6419577832955, 1141.4521029905525, 1256.9378874850736, 1267.14467734279, 1319.0634649399035, 1348.4740951029107, 1359.320339830085, 1383.4120498787975, 1409.0488919978973, 1413.039133389305, 7988.320992715684, 8141.470804397695, 8143.674253029931, 8190.467619604707, 8231.0, 1034.374203606822, 1201.7536405036947, 1217.5008246618843, 1218.165556593736, 1247.600767754328, 6195.349488303754, 6207.534434917399, 6272.560920735596, 6277.52918531112, 6299.181106456132, 10435.739106522398, 10750.139988800876, 10822.945885270523, 10826.89173108259, 10913.508892099715, 10458.424786636808, 10506.842397364046, 10727.463626818628, 10797.190210734227, 10808.02727754506, 8174.632141553644, 8293.253607175384, 8293.875591866126, 8300.460470069425, 8314.750557483285, 7682.615869206629, 7875.409344299086, 7889.368850491832, 7915.05019397676, 7931.5637639930355, 9353.11145441182, 9401.670941517013, 9535.998720134286, 9594.992525784692, 9724.562394692397, 9746.0, 9843.753906152404, 9848.0, 9864.013598640078, 9996.350237234556, 6586.604803711793, 7125.18060423058, 7448.292412220831, 7527.8118047049265, 7546.811329716801, 8149.429539932148, 8155.062167850773, 8201.30288925448, 8202.794930126794, 8235.50586964784, 7156.821079473055, 7224.8916266255, 7247.782566523013, 7348.926510735038, 7394.260573942563, 7141.250168732416, 7182.640867956686, 7279.599622020628, 7302.379297759538, 7302.525335853153, 6170.81487555374, 7614.847703046019, 7647.541147531166, 7665.42509311815, 7666.233376662289, 6943.930560694328, 6979.930200697928, 6980.406665433495, 6996.195437524546, 6999.30006999296, 6688.765893193715, 6852.588844669336, 6894.931050689429, 6904.516683832084, 6909.550879192836], "unit": "score", "name": "mootools.html", "value": 4892.037137434027}, {"lowerIsBetter": false, "replicates": [321.9517072439134, 324.6234368132966, 328.2859779978546, 330.41681432272037, 333.9582552180979, 6506.284308726043, 6559.508036897228, 6588.967055164718, 6598.439132673717, 6601.768938087168, 6409.775657851976, 6476.384743449376, 6487.286398496173, 6489.967550162242, 6505.90241146382, 4631.073785242948, 4701.600363969067, 4739.763011849411, 4854.320395144674, 4861.659683822134, 4774.952250477486, 4792.928106078394, 4796.640251981098, 4801.951980480186, 4854.87862803431, 3885.61143885612, 4765.69023013503, 4787.329773831666, 4821.30091136785, 4830.033993201374, 4352.064306174188, 4527.094581083797, 4624.514425985273, 4739.123262196505, 4770.165221086296, 3750.5124333836698, 4097.467329247179, 4116.094459218967, 4116.176764647053, 4118.217538667644, 6139.26328840542, 6163.568550201488, 6163.907541386883, 6178.5366097542865, 6183.628982261033, 5660.943390566083, 5661.0, 5666.801661941812, 5680.943190568124, 5702.686352250625, 6796.0, 6796.932030679679, 6798.184217893835, 6802.693878775467, 6803.081583986148, 4478.104379124188, 4671.95328046722, 4676.597020893718, 4680.134175177569, 4689.95310046902, 7067.752628657972, 7274.818129546804, 7291.8906216406795, 7304.196538380774, 7317.707291708379, 4030.7783071931326, 4711.81152753886, 4766.904661906812, 4772.236442169236, 4801.207800712913, 4825.9034819303415, 4836.733979631154, 4838.927416088762, 4842.58837998767, 4853.878653033632, 5650.802221922213, 5662.971685141548, 5667.064934285879, 5668.376478587352, 5676.943230567724, 6710.6481369275, 6886.758963436256, 6922.376986071277, 6934.271901450376, 6941.930580694229, 1406.69052808382, 1660.3396603396604, 1670.5322509697305, 1687.687777761118, 1690.6111594333372, 1035.471909326249, 1072.8873468285874, 1097.544519024596, 1106.2919731371928, 1130.796456637813, 5759.164921086419, 5990.820275391745, 6298.937010629835, 6319.778807741707, 6386.872262554816, 7250.984862119308, 7267.0552828132, 7272.600006999666, 7277.2722727726805, 7282.599457029914, 6523.641199733966, 6543.051257567721, 6543.901841472381, 6545.803625891231, 6557.639329836905, 3753.868614598476, 3809.7523660961947, 3832.559255685576, 3834.9616503835164, 3844.6539811417106, 7356.970024196617, 7635.732749353746, 7644.12092609357, 7658.195889431529, 7679.846403071907, 7437.070366204224, 7506.587137707369, 7528.5859277739155, 7544.698212071566, 7550.773476795595, 6084.847878803065, 7579.962100189464, 7591.4685971981435, 7601.277878601524, 7616.885746713804, 7042.190148132825, 7275.708971641287, 7296.744613938699, 7298.854022919406, 7302.415806735555, 7107.538010029331, 7158.284171583008, 7160.928390716026, 7164.713411463483, 7185.964070179615, 7574.3183113520045, 7610.391168706379, 7615.7334493292465, 7624.123225828879, 7626.656800443882, 3781.7920014399474, 4625.288643202037, 4628.67599268048, 4638.234691275901, 4642.651801114863, 6958.756443524452, 7234.5659260444545, 7237.963810181126, 7246.492745507764, 7249.130104387296, 6971.965140174267, 6983.825404364931, 6991.021257024123, 6998.895016574654, 7009.404200643003, 6901.275366086488, 6958.652067396712, 6981.232064472802, 6988.40598549129, 6999.51003429755, 6764.120664313607, 6775.62734049632, 6780.864382712417, 6787.389134977876, 6803.795886123424, 6694.564853284521, 6950.582965022115, 6993.895091573529, 6997.825054373681, 6999.265077166824, 6541.803745887631, 6681.498887583353, 6756.729730810909, 6822.761203357859, 6839.316068393121], "unit": "score", "name": "prototype.html", "value": 5104.27624610196}, {"lowerIsBetter": false, "replicates": [659.123365923322, 685.3797313431345, 756.5914406220642, 756.9886451703223, 810.8378324335134, 15000.324985375657, 15199.468018619351, 15205.4678086267, 15205.847941520582, 15227.847721522781, 13924.651883702913, 13968.93015534921, 13988.720225595507, 13996.300184990761, 14044.157350558948, 726.920038795732, 738.1695592458484, 889.1997202517721, 891.9965039330737, 905.7645012296784, 912.0879120879121, 913.8766266553996, 916.0381599320687, 916.294453270981, 917.7338571814166, 747.6411322565172, 977.9853302200472, 978.9755256118583, 979.5347210075229, 980.206033113177, 774.930256276935, 943.2878176976408, 970.3110791338123, 974.2108891797667, 974.2741657465234, 724.5000949344987, 724.768074216251, 726.8437285983539, 727.2436665867491, 727.4907564704675, 14642.341094650767, 15054.397824087024, 15057.54827355181, 15061.698766024727, 15070.0, 12619.810702839464, 12662.55681051168, 12832.743345133045, 12980.870191298061, 13090.738185236241, 9872.35829671069, 10090.798184036279, 10143.340682855665, 10412.010858968386, 10591.947040264826, 3473.2532505511185, 3604.6575575320303, 3652.4156135018534, 3653.7807731535927, 3671.118931456458, 83842.58078709568, 84520.30959380777, 85685.71471427934, 86693.26613467696, 86698.0, 9326.72019839406, 9337.673181438753, 9495.192908602708, 9549.851283461167, 9615.56729947154, 20416.489587760127, 20475.692864607045, 20496.18015279402, 20499.07754151067, 20517.076731547117, 7128.358447739728, 7277.417806575461, 7438.925610743823, 7458.552486850806, 7587.924120758832, 3971.4241434991764, 4027.617376349242, 4104.8152833122585, 4117.835286588563, 4118.176364727066, 3531.3643544161782, 3577.0878426001204, 3578.355895938756, 3582.0, 3582.7133829294116, 651.1437459740426, 659.8119535932236, 663.2604645819877, 663.3697986912356, 675.5136301862651, 539.8947205295009, 575.9539236861041, 592.5437413191818, 598.3478008970243, 618.9597676151036, 7866.488678235896, 8008.27925486709, 8067.152948940394, 8280.130586288473, 8326.70856520031, 584.3105135939632, 598.9760409583655, 603.8218725475907, 611.1413464082971, 633.7021599848064, 3725.4225595032813, 3754.4743735877, 3791.658750712449, 3832.2718683450057, 3861.2663593917064, 78867.0, 80256.79614805782, 80359.0, 80368.79446808303, 80456.59771701104, 80328.598357009, 82469.17530824734, 82850.58574707087, 83430.0, 83588.0, 69807.0, 70730.0, 71083.0, 71716.64141679363, 71928.64035679789, 7670.8082297943, 7768.650410731418, 7770.0, 7841.09827369837, 7853.625191475837, 49459.258111127645, 51668.74165629148, 51681.224781627556, 52775.20837187368, 52859.471405285454, 67379.0, 69747.0, 70977.0, 71816.0, 72985.27014729785, 9810.460424676712, 9906.25703072258, 11363.318200907972, 11433.59982400612, 11450.427478625868, 11805.291682499077, 12072.879271207526, 12252.816207756712, 12563.434645440795, 12684.746305073662, 11476.196666233283, 11855.76288474243, 11884.34636095023, 11964.401779911144, 12134.929616614096, 9367.344285899922, 11331.716707082389, 11425.485853136795, 11681.240719353214, 11843.526258949545, 11412.828807567726, 11664.183507154758, 11742.765144697229, 11777.705557360792, 12364.19632723906, 9565.617375305188, 9628.0, 9635.855462167932, 9641.566129524048, 9860.654877079267, 7645.599080976672, 8922.73231803047, 9222.95388523053, 9621.615135394506, 9659.565319560495], "unit": "score", "name": "yui.html", "value": 6906.99470522923}], "name": "dromaeo_css", "value": 7475.463207860523}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 110.0, 110.0, 112.0, 111.0, 116.0, 110.0, 109.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 141.0, 156.0, 117.0, 141.0, 138.0, 141.0, 176.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 140.4}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 185.0, 186.0, 186.0, 186.0, 221.0, 260.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 195.8}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 83.0, 75.0, 57.0, 77.0, 85.0, 81.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.4}, {"lowerIsBetter": true, "replicates": [77.0, 95.0, 165.0, 119.0, 78.0, 82.0, 115.0, 78.0, 105.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 85.0, 90.0, 87.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 87.0, 86.0, 86.0, 85.0, 84.0, 95.0, 132.0, 139.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 52.0, 54.0, 53.0, 55.0, 65.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 69.0, 78.0, 75.0, 71.0, 67.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 83.0, 81.0, 80.0, 84.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [136.0, 132.0, 142.0, 126.0, 120.0, 118.0, 123.0, 122.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 137.0, 138.0, 137.0, 122.0, 140.0, 137.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.9}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1440.1}]} 16:09:11 INFO - Return code: 0 16:09:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:09:11 ERROR - # TBPL SUCCESS # 16:09:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:09:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:09:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:09:11 INFO - 2016-03-17 16:09:11.894 screenresolution[1678:9567] starting screenresolution argv=screenresolution get 16:09:11 INFO - 2016-03-17 16:09:11.896 screenresolution[1678:9567] Display 0: 1600x1200x32@60 16:09:11 INFO - 2016-03-17 16:09:11.902 screenresolution[1679:9570] starting screenresolution argv=screenresolution list 16:09:11 INFO - Available Modes on Display 0 16:09:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:09:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:09:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:09:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:09:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:09:12 INFO - Intel Iris: 16:09:12 INFO - Chipset Model: Intel Iris 16:09:12 INFO - Type: GPU 16:09:12 INFO - Bus: Built-In 16:09:12 INFO - VRAM (Dynamic, Max): 1536 MB 16:09:12 INFO - Vendor: Intel (0x8086) 16:09:12 INFO - Device ID: 0x0a2e 16:09:12 INFO - Revision ID: 0x0009 16:09:12 INFO - Displays: 16:09:12 INFO - Display: 16:09:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:09:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:09:12 INFO - Display Serial Number: 1600x1200 60 16:09:12 INFO - Main Display: Yes 16:09:12 INFO - Mirror: Off 16:09:12 INFO - Online: Yes 16:09:12 INFO - Rotation: Supported 16:09:12 INFO - Return code: 0 16:09:12 INFO - Running post-action listener: _resource_record_post_action 16:09:12 INFO - Running post-run listener: _resource_record_post_run 16:09:13 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39560704; Write bytes: 703778304; Read time: 457; Write time: 1989 16:09:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399864320; Write bytes: 393627648; Read time: 30250; Write time: 693 16:09:13 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37733888; Write bytes: 299083264; Read time: 438; Write time: 1264 16:09:13 INFO - Running post-run listener: _upload_blobber_files 16:09:13 INFO - Blob upload gear active. 16:09:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:13 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 16:09:13 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'] 16:09:13 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 16:09:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:14 INFO - (blobuploader) - INFO - Done attempting. 16:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:16 INFO - (blobuploader) - INFO - Done attempting. 16:09:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:16 INFO - Return code: 0 16:09:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91b67e25fcff316972f045eab7fe0858c3a250e5c129cfed7be196ea990abf2a51632eb6350d6c3554a49ab2b7f48bf514a073156b9f4f365e2bff4b2111aca8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ab2b39e069a8c118a3c51b6d9612514270627f52186755089b46bda440194d9e61adc8f49c0e3c3c286bb1be5f8d69cca79efc6d2a5a8150de43703550c79a5"} 16:09:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:16 INFO - Contents: 16:09:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91b67e25fcff316972f045eab7fe0858c3a250e5c129cfed7be196ea990abf2a51632eb6350d6c3554a49ab2b7f48bf514a073156b9f4f365e2bff4b2111aca8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ab2b39e069a8c118a3c51b6d9612514270627f52186755089b46bda440194d9e61adc8f49c0e3c3c286bb1be5f8d69cca79efc6d2a5a8150de43703550c79a5"} 16:09:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:16 INFO - Copying logs to upload dir... 16:09:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.346228 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-17 16:09:16.368225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 16:09:16.371974) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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/91b67e25fcff316972f045eab7fe0858c3a250e5c129cfed7be196ea990abf2a51632eb6350d6c3554a49ab2b7f48bf514a073156b9f4f365e2bff4b2111aca8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ab2b39e069a8c118a3c51b6d9612514270627f52186755089b46bda440194d9e61adc8f49c0e3c3c286bb1be5f8d69cca79efc6d2a5a8150de43703550c79a5"} build_url:https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/GZvuqPvnS96U11VY5MirIg/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/91b67e25fcff316972f045eab7fe0858c3a250e5c129cfed7be196ea990abf2a51632eb6350d6c3554a49ab2b7f48bf514a073156b9f4f365e2bff4b2111aca8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ab2b39e069a8c118a3c51b6d9612514270627f52186755089b46bda440194d9e61adc8f49c0e3c3c286bb1be5f8d69cca79efc6d2a5a8150de43703550c79a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 16:09:16.404281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:09:16.405031) ========= 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.LK1EV7jVpi/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.B3kc1Lmtyd/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.004990 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 16:09:16.458059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 16:09:16.458767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 16:09:16.459607) ========= ========= Total master_lag: 0.27 =========