builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0126 starttime: 1459292848.09 results: success (0) buildid: 20160329143234 builduid: 90c9958c84c94d82a0d527c038b022a3 revision: d8b9796cb557cdfa7d57abb586a0bcedf60cf676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.086761) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.087236) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.087541) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005719 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.119758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.120148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.140070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.140446) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005325 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.189019) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.189322) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.192928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.193307) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-29 16:07:28-- 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% 8.65M=0.001s 2016-03-29 16:07:28 (8.65 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151588 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.386762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.387158) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.019763 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:28.439554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 16:07:28.443032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8b9796cb557cdfa7d57abb586a0bcedf60cf676 --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 d8b9796cb557cdfa7d57abb586a0bcedf60cf676 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-29 16:07:28,518 truncating revision to first 12 chars 2016-03-29 16:07:28,518 Setting DEBUG logging. 2016-03-29 16:07:28,518 attempt 1/10 2016-03-29 16:07:28,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8b9796cb557?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 16:07:29,251 unpacking tar archive at: fx-team-d8b9796cb557/testing/mozharness/ program finished with exit code 0 elapsedTime=0.996050 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 16:07:29.741376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:29.741825) ========= echo d8b9796cb557cdfa7d57abb586a0bcedf60cf676 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd8b9796cb557cdfa7d57abb586a0bcedf60cf676'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 d8b9796cb557cdfa7d57abb586a0bcedf60cf676 program finished with exit code 0 elapsedTime=0.005147 script_repo_revision: 'd8b9796cb557cdfa7d57abb586a0bcedf60cf676' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:29.773443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:29.773856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 16:07:29.795474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-29 16:07:29.795897) ========= /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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:07:29 INFO - MultiFileLogger online at 20160329 16:07:29 in /builds/slave/test 16:07:29 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 16:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:07:29 INFO - {'append_to_log': False, 16:07:29 INFO - 'base_work_dir': '/builds/slave/test', 16:07:29 INFO - 'blob_upload_branch': 'Fx-Team', 16:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:07:29 INFO - 'branch': 'Fx-Team', 16:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:07:29 INFO - 'config_files': ('talos/mac_config.py',), 16:07:29 INFO - 'default_actions': ('clobber', 16:07:29 INFO - 'read-buildbot-config', 16:07:29 INFO - 'download-and-extract', 16:07:29 INFO - 'populate-webroot', 16:07:29 INFO - 'create-virtualenv', 16:07:29 INFO - 'install', 16:07:29 INFO - 'run-tests'), 16:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:07:29 INFO - 'download_minidump_stackwalk': True, 16:07:29 INFO - 'download_symbols': 'ondemand', 16:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:07:29 INFO - 'installer_path': 'installer.exe', 16:07:29 INFO - 'log_level': 'info', 16:07:29 INFO - 'log_name': 'talos', 16:07:29 INFO - 'log_to_console': True, 16:07:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:07:29 INFO - 'opt_config_files': (), 16:07:29 INFO - 'pip_index': False, 16:07:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:07:29 INFO - 'cmd': ('bash', 16:07:29 INFO - '-c', 16:07:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:07:29 INFO - 'enabled': True, 16:07:29 INFO - 'halt_on_failure': False, 16:07:29 INFO - 'name': 'check_screen_resolution'},), 16:07:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:07:29 INFO - 'cmd': ('bash', 16:07:29 INFO - '-c', 16:07:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:07:29 INFO - 'enabled': True, 16:07:29 INFO - 'halt_on_failure': False, 16:07:29 INFO - 'name': 'check_screen_resolution'},), 16:07:29 INFO - 'run_cmd_checks_enabled': True, 16:07:29 INFO - 'sps_profile': False, 16:07:29 INFO - 'sps_profile_interval': 0, 16:07:29 INFO - 'suite': 'dromaeojs', 16:07:29 INFO - 'system_bits': '32', 16:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:07:29 INFO - 'title': 't-yosemite-r7-0126', 16:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:07:29 INFO - 'use_talos_json': True, 16:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:07:29 INFO - 'work_dir': 'build'} 16:07:29 INFO - ##### 16:07:29 INFO - ##### Running clobber step. 16:07:29 INFO - ##### 16:07:29 INFO - Running pre-action listener: _resource_record_pre_action 16:07:29 INFO - Running main action method: clobber 16:07:29 INFO - rmtree: /builds/slave/test/build 16:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:07:31 INFO - Running post-action listener: _resource_record_post_action 16:07:31 INFO - ##### 16:07:31 INFO - ##### Running read-buildbot-config step. 16:07:31 INFO - ##### 16:07:31 INFO - Running pre-action listener: _resource_record_pre_action 16:07:31 INFO - Running main action method: read_buildbot_config 16:07:31 INFO - Using buildbot properties: 16:07:31 INFO - { 16:07:31 INFO - "project": "", 16:07:31 INFO - "product": "firefox", 16:07:31 INFO - "script_repo_revision": "production", 16:07:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:07:31 INFO - "repository": "", 16:07:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:07:31 INFO - "buildid": "20160329143234", 16:07:31 INFO - "pgo_build": "False", 16:07:31 INFO - "basedir": "/builds/slave/test", 16:07:31 INFO - "buildnumber": 647, 16:07:31 INFO - "slavename": "t-yosemite-r7-0126", 16:07:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:07:31 INFO - "platform": "yosemite_r7", 16:07:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:07:31 INFO - "branch": "fx-team", 16:07:31 INFO - "repo_path": "integration/fx-team", 16:07:31 INFO - "revision": "d8b9796cb557cdfa7d57abb586a0bcedf60cf676", 16:07:31 INFO - "stage_platform": "macosx64", 16:07:31 INFO - "builduid": "90c9958c84c94d82a0d527c038b022a3", 16:07:31 INFO - "slavebuilddir": "test" 16:07:31 INFO - } 16:07:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:07:31 INFO - Running post-action listener: _resource_record_post_action 16:07:31 INFO - ##### 16:07:31 INFO - ##### Running download-and-extract step. 16:07:31 INFO - ##### 16:07:31 INFO - Running pre-action listener: _resource_record_pre_action 16:07:31 INFO - Running main action method: download_and_extract 16:07:31 INFO - mkdir: /builds/slave/test/build/tests 16:07:31 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')]} 16:07:31 INFO - https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:32 INFO - Downloaded 1199 bytes. 16:07:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:07:32 INFO - Using the following test package requirements: 16:07:32 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:07:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:07:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:07:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'jsshell-mac.zip'], 16:07:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:07:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:07:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:07:32 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:07:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:07:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:07:32 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:07:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:07:32 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')]} 16:07:32 INFO - https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:33 INFO - Downloaded 17944796 bytes. 16:07:33 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'] 16:07:33 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 16:07:36 INFO - Return code: 0 16:07:36 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 16:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:36 INFO - https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:39 INFO - Downloaded 17944796 bytes. 16:07:39 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'] 16:07:39 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 16:07:42 INFO - Return code: 0 16:07: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')]} 16:07:42 INFO - https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:43 INFO - Downloaded 10847531 bytes. 16:07:43 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'] 16:07:43 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 16:07:44 INFO - Return code: 0 16:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:44 INFO - https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DQOLymIsTrKJY6-PpPY_0g/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 16:07:47 INFO - Downloaded 111409314 bytes. 16:07:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:07:47 INFO - mkdir: /builds/slave/test/properties 16:07:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:07:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:07:47 INFO - Contents: 16:07:47 INFO - build_url:https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:07:47 INFO - Running post-action listener: _resource_record_post_action 16:07:47 INFO - Running post-action listener: set_extra_try_arguments 16:07:47 INFO - ##### 16:07:47 INFO - ##### Running populate-webroot step. 16:07:47 INFO - ##### 16:07:47 INFO - Running pre-action listener: _resource_record_pre_action 16:07:47 INFO - Running main action method: populate_webroot 16:07:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:07:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:07:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:07:47 INFO - '--tppagecycles', 16:07:47 INFO - '7'], 16:07:47 INFO - 'tests': ['tsvgm']}}, 16:07:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:07:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:07:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:07:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:07:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:07:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'tests': ['damp', 'tps']}, 16:07:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['damp', 'tps']}, 16:07:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:07:47 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['dromaeo_dom']}, 16:07:47 INFO - 'other': {'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'other_l64': {'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'other_nol64': {'tests': ['a11yr', 16:07:47 INFO - 'ts_paint', 16:07:47 INFO - 'tpaint', 16:07:47 INFO - 'sessionrestore', 16:07:47 INFO - 'sessionrestore_no_auto_restore', 16:07:47 INFO - 'tabpaint']}, 16:07:47 INFO - 'svgr': {'tests': ['tsvgx', 16:07:47 INFO - 'tsvgr_opacity', 16:07:47 INFO - 'tart', 16:07:47 INFO - 'tscrollx', 16:07:47 INFO - 'cart']}, 16:07:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['tsvgx', 16:07:47 INFO - 'tsvgr_opacity', 16:07:47 INFO - 'tart', 16:07:47 INFO - 'tscrollx', 16:07:47 INFO - 'cart']}, 16:07:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'tests': ['tp5o']}, 16:07:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'talos_options': ['--e10s'], 16:07:47 INFO - 'tests': ['tp5o']}, 16:07:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'talos_options': ['--xperf_path', 16:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:47 INFO - 'tests': ['tp5n']}, 16:07:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:07:47 INFO - 'talos_options': ['--e10s', 16:07:47 INFO - '--xperf_path', 16:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:07:47 INFO - 'tests': ['tp5n']}}, 16:07:47 INFO - 'talos.zip': {'path': '', 16:07:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:07:47 INFO - Running post-action listener: _resource_record_post_action 16:07:47 INFO - ##### 16:07:47 INFO - ##### Running create-virtualenv step. 16:07:47 INFO - ##### 16:07:47 INFO - Running pre-action listener: _resource_record_pre_action 16:07:47 INFO - Running main action method: create_virtualenv 16:07:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:07:47 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 16:07:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:07:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:07:47 INFO - Using real prefix '/tools/python27' 16:07:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:07:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:07:51 INFO - Installing pip.................done. 16:07:51 INFO - Return code: 0 16:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:07:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:07:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:07:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:07:51 INFO - 'HOME': '/Users/cltbld', 16:07:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:07:51 INFO - 'LOGNAME': 'cltbld', 16:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:51 INFO - 'MOZ_NO_REMOTE': '1', 16:07:51 INFO - 'NO_EM_RESTART': '1', 16:07:51 INFO - 'PAGER': '/bin/cat', 16:07:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:51 INFO - 'PWD': '/builds/slave/test', 16:07:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:07:51 INFO - 'SHELL': '/bin/bash', 16:07:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:07:51 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:07:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:07:51 INFO - 'USER': 'cltbld', 16:07:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:07:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:51 INFO - 'XPC_FLAGS': '0x0', 16:07:51 INFO - 'XPC_SERVICE_NAME': '0', 16:07:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:51 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 16:07:51 INFO - Cleaning up... 16:07:51 INFO - Return code: 0 16:07:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:07:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:07:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:07:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:07:51 INFO - 'HOME': '/Users/cltbld', 16:07:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:07:51 INFO - 'LOGNAME': 'cltbld', 16:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:51 INFO - 'MOZ_NO_REMOTE': '1', 16:07:51 INFO - 'NO_EM_RESTART': '1', 16:07:51 INFO - 'PAGER': '/bin/cat', 16:07:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:51 INFO - 'PWD': '/builds/slave/test', 16:07:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:07:51 INFO - 'SHELL': '/bin/bash', 16:07:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:07:51 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:07:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:07:51 INFO - 'USER': 'cltbld', 16:07:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:07:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:51 INFO - 'XPC_FLAGS': '0x0', 16:07:51 INFO - 'XPC_SERVICE_NAME': '0', 16:07:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:52 INFO - Downloading/unpacking psutil>=0.7.1 16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:07:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:55 INFO - Installing collected packages: psutil 16:07:55 INFO - Running setup.py install for psutil 16:07:55 INFO - building 'psutil._psutil_osx' extension 16:07:55 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 16:07:55 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 16:07:55 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 16:07:55 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 16:07:55 INFO - building 'psutil._psutil_posix' extension 16:07:55 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 16:07:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:07:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:07:55 INFO - ^ 16:07:55 INFO - 1 warning generated. 16:07:55 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 16:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:07:56 INFO - Successfully installed psutil 16:07:56 INFO - Cleaning up... 16:07:56 INFO - Return code: 0 16:07:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:07: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')]} 16:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07: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')]} 16:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:07:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:07:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:07:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:07:56 INFO - 'HOME': '/Users/cltbld', 16:07:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:07:56 INFO - 'LOGNAME': 'cltbld', 16:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:56 INFO - 'MOZ_NO_REMOTE': '1', 16:07:56 INFO - 'NO_EM_RESTART': '1', 16:07:56 INFO - 'PAGER': '/bin/cat', 16:07:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:56 INFO - 'PWD': '/builds/slave/test', 16:07:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:07:56 INFO - 'SHELL': '/bin/bash', 16:07:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:07:56 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:07:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:07:56 INFO - 'USER': 'cltbld', 16:07:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:07:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:56 INFO - 'XPC_FLAGS': '0x0', 16:07:56 INFO - 'XPC_SERVICE_NAME': '0', 16:07:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:07:59 INFO - Installing collected packages: mozsystemmonitor 16:07:59 INFO - Running setup.py install for mozsystemmonitor 16:07:59 INFO - Successfully installed mozsystemmonitor 16:07:59 INFO - Cleaning up... 16:07:59 INFO - Return code: 0 16:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:59 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:07:59 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 16:07:59 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 16:07:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:07:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:07:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:07:59 INFO - 'HOME': '/Users/cltbld', 16:07:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:07:59 INFO - 'LOGNAME': 'cltbld', 16:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:59 INFO - 'MOZ_NO_REMOTE': '1', 16:07:59 INFO - 'NO_EM_RESTART': '1', 16:07:59 INFO - 'PAGER': '/bin/cat', 16:07:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:59 INFO - 'PWD': '/builds/slave/test', 16:07:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:07:59 INFO - 'SHELL': '/bin/bash', 16:07:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:07:59 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:07:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:07:59 INFO - 'USER': 'cltbld', 16:07:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:07:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:59 INFO - 'XPC_FLAGS': '0x0', 16:07:59 INFO - 'XPC_SERVICE_NAME': '0', 16:07:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:07: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 16:08:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:08:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:03 INFO - Downloading docopt-0.6.1.tar.gz 16:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:08:03 INFO - Running setup.py install for blobuploader 16:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:08:03 INFO - Running setup.py install for requests 16:08:03 INFO - Running setup.py install for docopt 16:08:04 INFO - Successfully installed blobuploader requests docopt 16:08:04 INFO - Cleaning up... 16:08:04 INFO - Return code: 0 16:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:04 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:08:04 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 16:08:04 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 16:08:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:04 INFO - 'HOME': '/Users/cltbld', 16:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:04 INFO - 'LOGNAME': 'cltbld', 16:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:04 INFO - 'MOZ_NO_REMOTE': '1', 16:08:04 INFO - 'NO_EM_RESTART': '1', 16:08:04 INFO - 'PAGER': '/bin/cat', 16:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:04 INFO - 'PWD': '/builds/slave/test', 16:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:04 INFO - 'SHELL': '/bin/bash', 16:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:04 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:04 INFO - 'USER': 'cltbld', 16:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:04 INFO - 'XPC_FLAGS': '0x0', 16:08:04 INFO - 'XPC_SERVICE_NAME': '0', 16:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qe7Ntu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-xT8R4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-OoRIHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-nLqtjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-MUlhkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-kB50RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:04 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-RdhfcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-09Tu1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ZYj7IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ULXs4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-P3UpP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-C7tt0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-YpNEXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-GLTmOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-RHVxAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:05 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-fwNGQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:06 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-7bQ_j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:08:06 INFO - Running setup.py install for manifestparser 16:08:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:08:06 INFO - Running setup.py install for mozcrash 16:08:06 INFO - Running setup.py install for mozdebug 16:08:06 INFO - Running setup.py install for mozdevice 16:08:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:08:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:08:06 INFO - Running setup.py install for mozfile 16:08:06 INFO - Running setup.py install for mozhttpd 16:08:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Running setup.py install for mozinfo 16:08:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Running setup.py install for mozInstall 16:08:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Running setup.py install for mozleak 16:08:07 INFO - Running setup.py install for mozlog 16:08:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Running setup.py install for moznetwork 16:08:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:08:07 INFO - Running setup.py install for mozprocess 16:08:07 INFO - Running setup.py install for mozprofile 16:08:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Running setup.py install for mozrunner 16:08:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Running setup.py install for mozscreenshot 16:08:08 INFO - Running setup.py install for moztest 16:08:08 INFO - Running setup.py install for mozversion 16:08:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:08:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:08:08 INFO - Cleaning up... 16:08:08 INFO - Return code: 0 16:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:08 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:08:08 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 16:08:08 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 16:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:08 INFO - 'HOME': '/Users/cltbld', 16:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:08 INFO - 'LOGNAME': 'cltbld', 16:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:08 INFO - 'MOZ_NO_REMOTE': '1', 16:08:08 INFO - 'NO_EM_RESTART': '1', 16:08:08 INFO - 'PAGER': '/bin/cat', 16:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:08 INFO - 'PWD': '/builds/slave/test', 16:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:08 INFO - 'SHELL': '/bin/bash', 16:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:08 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:08 INFO - 'USER': 'cltbld', 16:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:08 INFO - 'XPC_FLAGS': '0x0', 16:08:08 INFO - 'XPC_SERVICE_NAME': '0', 16:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:08:08 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FWGLMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-YP10sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_ebvNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-wpNxOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-cdluJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-tPKont-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-kWgChN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-zgp8n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-CFKalP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:08:09 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)) 16:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:08:09 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5RIIKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-HI1vD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BdsgOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-sDT1zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-L4tmXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-1O3LU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-PYiYgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:08:10 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)) 16:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:08:10 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Id0Mva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:08:10 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)) 16:08:10 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)) 16:08:10 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)) 16:08:10 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)) 16:08:10 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)) 16:08:10 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)) 16:08:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:08:10 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 16:08:10 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 16:08:10 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 16:08:10 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 16:08:10 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 16:08:10 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 16:08:14 INFO - Downloading blessings-1.6.tar.gz 16:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:08:14 INFO - Installing collected packages: blessings 16:08:14 INFO - Running setup.py install for blessings 16:08:14 INFO - Successfully installed blessings 16:08:14 INFO - Cleaning up... 16:08:14 INFO - Return code: 0 16:08:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:14 INFO - Reading from file tmpfile_stdout 16:08:14 INFO - Current package versions: 16:08:14 INFO - blessings == 1.6 16:08:14 INFO - blobuploader == 1.2.4 16:08:14 INFO - docopt == 0.6.1 16:08:14 INFO - manifestparser == 1.1 16:08:14 INFO - mozInstall == 1.12 16:08:14 INFO - mozcrash == 0.17 16:08:14 INFO - mozdebug == 0.1 16:08:14 INFO - mozdevice == 0.48 16:08:14 INFO - mozfile == 1.2 16:08:14 INFO - mozhttpd == 0.7 16:08:14 INFO - mozinfo == 0.9 16:08:14 INFO - mozleak == 0.1 16:08:14 INFO - mozlog == 3.1 16:08:14 INFO - moznetwork == 0.27 16:08:14 INFO - mozprocess == 0.22 16:08:14 INFO - mozprofile == 0.28 16:08:14 INFO - mozrunner == 6.11 16:08:14 INFO - mozscreenshot == 0.1 16:08:14 INFO - mozsystemmonitor == 0.0 16:08:14 INFO - moztest == 0.7 16:08:14 INFO - mozversion == 1.4 16:08:14 INFO - psutil == 3.1.1 16:08:14 INFO - requests == 1.2.3 16:08:14 INFO - wsgiref == 0.1.2 16:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:14 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:08:14 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 16:08:14 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 16:08:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:14 INFO - 'HOME': '/Users/cltbld', 16:08:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:14 INFO - 'LOGNAME': 'cltbld', 16:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:14 INFO - 'MOZ_NO_REMOTE': '1', 16:08:14 INFO - 'NO_EM_RESTART': '1', 16:08:14 INFO - 'PAGER': '/bin/cat', 16:08:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:14 INFO - 'PWD': '/builds/slave/test', 16:08:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:14 INFO - 'SHELL': '/bin/bash', 16:08:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:14 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:14 INFO - 'USER': 'cltbld', 16:08:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:14 INFO - 'XPC_FLAGS': '0x0', 16:08:14 INFO - 'XPC_SERVICE_NAME': '0', 16:08:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 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)) 16:08:15 INFO - Cleaning up... 16:08:15 INFO - Return code: 0 16:08:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:08:15 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')]} 16:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:15 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')]} 16:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:15 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:08:15 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 16:08:15 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 16:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:15 INFO - 'HOME': '/Users/cltbld', 16:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:15 INFO - 'LOGNAME': 'cltbld', 16:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:15 INFO - 'MOZ_NO_REMOTE': '1', 16:08:15 INFO - 'NO_EM_RESTART': '1', 16:08:15 INFO - 'PAGER': '/bin/cat', 16:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:15 INFO - 'PWD': '/builds/slave/test', 16:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:15 INFO - 'SHELL': '/bin/bash', 16:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:15 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:15 INFO - 'USER': 'cltbld', 16:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:15 INFO - 'XPC_FLAGS': '0x0', 16:08:15 INFO - 'XPC_SERVICE_NAME': '0', 16:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:15 INFO - Downloading/unpacking jsonschema 16:08:15 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 16:08:15 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 16:08:15 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 16:08:15 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 16:08:15 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 16:08:15 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 16:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:08:17 INFO - Downloading/unpacking functools32 (from jsonschema) 16:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:08:18 INFO - warning: no files found matching '*.txt' 16:08:18 INFO - no previously-included directories found matching 'build' 16:08:18 INFO - no previously-included directories found matching 'dist' 16:08:18 INFO - no previously-included directories found matching '.git*' 16:08:18 INFO - Installing collected packages: jsonschema, functools32 16:08:18 INFO - Running setup.py install for functools32 16:08:18 INFO - warning: no files found matching '*.txt' 16:08:18 INFO - no previously-included directories found matching 'build' 16:08:18 INFO - no previously-included directories found matching 'dist' 16:08:18 INFO - no previously-included directories found matching '.git*' 16:08:18 INFO - Successfully installed jsonschema functools32 16:08:18 INFO - Cleaning up... 16:08:18 INFO - Return code: 0 16:08:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:08:18 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')]} 16:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:18 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')]} 16:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:08:18 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 0x1057e1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057f1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20a46fab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, '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.48hGshEyll/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.EZvlCpG2vf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 16:08:18 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 16:08:18 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 16:08:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:18 INFO - 'HOME': '/Users/cltbld', 16:08:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:18 INFO - 'LOGNAME': 'cltbld', 16:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:18 INFO - 'MOZ_NO_REMOTE': '1', 16:08:18 INFO - 'NO_EM_RESTART': '1', 16:08:18 INFO - 'PAGER': '/bin/cat', 16:08:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:18 INFO - 'PWD': '/builds/slave/test', 16:08:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:18 INFO - 'SHELL': '/bin/bash', 16:08:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:18 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:18 INFO - 'USER': 'cltbld', 16:08:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:18 INFO - 'XPC_FLAGS': '0x0', 16:08:18 INFO - 'XPC_SERVICE_NAME': '0', 16:08:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:08:18 INFO - Downloading/unpacking flake8 16:08:18 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 16:08:18 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 16:08:18 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 16:08:18 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 16:08:18 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 16:08:18 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 16:08:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:08:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:20 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 16:08:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:08:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:21 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 16:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:22 INFO - no previously-included directories found matching 'docs/_build' 16:08:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:08:22 INFO - Running setup.py install for pep8 16:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:08:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:08:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:08:22 INFO - no previously-included directories found matching 'docs/_build' 16:08:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:08:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:08:22 INFO - Cleaning up... 16:08:22 INFO - Return code: 0 16:08:22 INFO - Running post-action listener: _resource_record_post_action 16:08:22 INFO - Running post-action listener: _start_resource_monitoring 16:08:22 INFO - Starting resource monitoring. 16:08:22 INFO - ##### 16:08:22 INFO - ##### Running install step. 16:08:22 INFO - ##### 16:08:22 INFO - Running pre-action listener: _resource_record_pre_action 16:08:22 INFO - Running main action method: install 16:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:08:22 INFO - Reading from file tmpfile_stdout 16:08:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:08:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:08:22 INFO - Reading from file tmpfile_stdout 16:08:22 INFO - Output received: 16:08:22 INFO - Usage: mozinstall [options] installer 16:08:22 INFO - Options: 16:08:22 INFO - -h, --help show this help message and exit 16:08:22 INFO - -d DEST, --destination=DEST 16:08:22 INFO - Directory to install application into. [default: 16:08:22 INFO - "/builds/slave/test"] 16:08:22 INFO - --app=APP Application being installed. [default: firefox] 16:08:22 INFO - mkdir: /builds/slave/test/build/application 16:08:22 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'] 16:08:22 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 16:08:56 INFO - Reading from file tmpfile_stdout 16:08:56 INFO - Output received: 16:08:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:08:56 INFO - Running post-action listener: _resource_record_post_action 16:08:56 INFO - ##### 16:08:56 INFO - ##### Running run-tests step. 16:08:56 INFO - ##### 16:08:56 INFO - Running pre-action listener: _resource_record_pre_action 16:08:56 INFO - Running main action method: run_tests 16:08:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:08:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:08:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:08:56 INFO - 2016-03-29 16:08:56.579 screenresolution[1935:11061] starting screenresolution argv=screenresolution get 16:08:56 INFO - 2016-03-29 16:08:56.582 screenresolution[1935:11061] Display 0: 1600x1200x32@60 16:08:56 INFO - 2016-03-29 16:08:56.587 screenresolution[1936:11063] starting screenresolution argv=screenresolution list 16:08:56 INFO - Available Modes on Display 0 16:08:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:08:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:08:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:08:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:08:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:08:56 INFO - Intel Iris: 16:08:56 INFO - Chipset Model: Intel Iris 16:08:56 INFO - Type: GPU 16:08:56 INFO - Bus: Built-In 16:08:56 INFO - VRAM (Dynamic, Max): 1536 MB 16:08:56 INFO - Vendor: Intel (0x8086) 16:08:56 INFO - Device ID: 0x0a2e 16:08:56 INFO - Revision ID: 0x0009 16:08:56 INFO - Displays: 16:08:56 INFO - Display: 16:08:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:08:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:08:56 INFO - Display Serial Number: 1600x1200 60 16:08:56 INFO - Main Display: Yes 16:08:56 INFO - Mirror: Off 16:08:56 INFO - Online: Yes 16:08:56 INFO - Rotation: Supported 16:08:56 INFO - Return code: 0 16:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:08:56 INFO - Python 2.7.3 16:08:56 INFO - Return code: 0 16:08:56 INFO - grabbing minidump binary from tooltool 16:08: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')]} 16:08:56 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 0x105680e00>, '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 0x1054a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:08:56 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 16:08:56 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 16:08:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:08:56 INFO - Return code: 0 16:08:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:08:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:08:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:08:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:08:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:08:58 INFO - Return code: 0 16:08:58 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/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 16:08:58 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/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --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 16:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48hGshEyll/Render', 16:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:08:58 INFO - 'HOME': '/Users/cltbld', 16:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:08:58 INFO - 'LOGNAME': 'cltbld', 16:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:58 INFO - 'MOZ_NO_REMOTE': '1', 16:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:58 INFO - 'NO_EM_RESTART': '1', 16:08:58 INFO - 'PAGER': '/bin/cat', 16:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:58 INFO - 'PWD': '/builds/slave/test', 16:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:08:58 INFO - 'SHELL': '/bin/bash', 16:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EZvlCpG2vf/Listeners', 16:08:58 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 16:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:08:58 INFO - 'USER': 'cltbld', 16:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:58 INFO - 'XPC_FLAGS': '0x0', 16:08:58 INFO - 'XPC_SERVICE_NAME': '0', 16:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:08:58 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/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--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 16:08:58 INFO - mozversion application_buildid: 20160329143234 16:08:58 INFO - mozversion application_changeset: d8b9796cb557cdfa7d57abb586a0bcedf60cf676 16:08:58 INFO - mozversion application_display_name: Nightly 16:08:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:08:58 INFO - mozversion application_name: Firefox 16:08:58 INFO - mozversion application_remotingname: firefox 16:08:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:08:58 INFO - mozversion application_vendor: Mozilla 16:08:58 INFO - mozversion application_version: 48.0a1 16:08:58 INFO - mozversion platform_buildid: 20160329143234 16:08:58 INFO - mozversion platform_changeset: d8b9796cb557cdfa7d57abb586a0bcedf60cf676 16:08:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:08:58 INFO - mozversion platform_version: 48.0a1 16:08:58 INFO - using testdate: 1459292938 16:08:58 INFO - actual date: 1459292938 16:08:58 INFO - starting webserver on 'localhost:49483' 16:08:58 INFO - SUITE-START | Running 2 tests 16:08:58 INFO - TEST-START | dromaeo_css 16:08:58 INFO - operating with platform_type : mac_ 16:08:58 INFO - Initialising browser for dromaeo_css test... 16:08:58 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3owgea/profile http://localhost:49483/getInfo.html) 16:09:00 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 16:09:00 INFO - PROCESS | 1954 | colorDepth:24 16:09:00 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 16:09:00 INFO - PROCESS | 1954 | __metrics 16:09:00 INFO - PROCESS | 1954 | 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:09:00 ERROR - PROCESS | 1954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:09:01 INFO - TEST-INFO | 1954: exit 0 16:09:01 INFO - Browser initialized. 16:09:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:09:01 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3owgea/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:09:13 INFO - PROCESS | 1957 | RSS: Main: 244412416 16:09:13 INFO - PROCESS | 1957 | 16:10:05 INFO - PROCESS | 1957 | 1459293005100 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] 16:12:14 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49483/tests/dromaeo/cssquery-ext.html) 16:12:16 INFO - PROCESS | 1957 | RSS: Main: 340803584 16:12:16 INFO - PROCESS | 1957 | 16:15:18 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-ext.html (next: http://localhost:49483/tests/dromaeo/cssquery-jquery.html) 16:15:19 INFO - PROCESS | 1957 | RSS: Main: 377913344 16:15:19 INFO - PROCESS | 1957 | 16:18:21 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49483/tests/dromaeo/cssquery-mootools.html) 16:18:21 INFO - PROCESS | 1957 | RSS: Main: 371843072 16:18:21 INFO - PROCESS | 1957 | 16:21:23 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49483/tests/dromaeo/cssquery-prototype.html) 16:21:24 INFO - PROCESS | 1957 | RSS: Main: 331784192 16:21:24 INFO - PROCESS | 1957 | 16:24:27 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49483/tests/dromaeo/cssquery-yui.html) 16:24:28 INFO - PROCESS | 1957 | RSS: Main: 333340672 16:24:28 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49483/tests/dromaeo/cssquery-yui.html (next: http://localhost:49483/tests/dromaeo/cssquery-dojo.html) 16:27:31 INFO - PROCESS | 1957 | RSS: Main: 386404352 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | __start_tp_report 16:27:31 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 16:27:31 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 16:27:31 INFO - PROCESS | 1957 | |i|pagename|runs| 16:27:31 INFO - PROCESS | 1957 | |0;dojo.html;3432.5537680101593;3452.361313157066;3470.357983773002;3496.6852983231506;3531.9117022074447;5544.22380866679;5641.548676105912;5666.178404131399;5693.943060569393;5706.0014497462935;5634;5687.857803554903;5762.049261871786;5775.509081728048;5795.21764561784;4223.936640950388;5077.136886729265;5120.641555091126;5149.253358263069;5239.083160446926;5231.816886408977;5233.816816411427;5255.05409026377;5278.076336641092;5296.576273898079;5056.292119103328;5144.536991670768;5154.871128221787;5206.193040078794;5211.270422140884;5139.974300128512;5168.8966220675375;5171.095058364809;5174.974125129388;5175.223716442564;5095.847124586268;5122.718250496221;5146.459621739738;5156.1750119980625;5161;5579.995600791855;5586.13414920688;5590.496855283044;5594.356648985378;5596.552275817925;6110.052941793984;6205.410486003822;6228.750849965996;6243.063540468921;6245.094461303131;6140.171076904606;6255.06174073888;6303.684815759239;6318.115463835067;6322.841928951767;4913.631477639191;5794.971025144847;5806.796762113306;5811.186433899215;5828.03837366834;6224.097505861625;6267.2165979252595;6272;6276.403741644536;6287.1198032275515;6000.406236221412;6057.727402266909;6132.724027418777;6133.304060594615;6154.046122850965;6224.9377506224355;6275.152854364603;6279.811605651837;6300.054991751274;6302.432781049728;6200.441960223601;6203.379662033761;6211.223597050369;6218.657973811393;6232.252129744369;6051.939480605226;6099.897739344564;6131.468419844996;6170.691465426711;6220.471259942956;4831.661783675179;4855.854324370274;4863.148948933923;4884.438289596671;4900.681455705368;4344.500382455994;4352.586504282088;4359.934600980988;4372.562743725665;4415.094905544356;5575.275214222206;5678.914816277759;5697.287839020122;5721.342045664802;5747.741351639186;5137.588992880561;6261.092141639437;6276.309605943343;6279.623222606567;6284.308726040132;5655.604107712503;5655.688937108499;5677.858053548612;5683.60214784961;5688.402717714663;5289.259503669489;5325;5366.597505187126;5396.811111611075;5406.54044406222;6272.6236425814595;6298.622082675054;6310.873782524232;6311.431971122621;6313.90529142054;6185.690715464299;6286.402791734778;6288.496920246461;6309.085182648582;6313.05304204373;5161.896762064813;6138.664296166039;6263.906041409474;6278.372162783685;6294.276158241861;6165;6179.412955769195;6179.721912514037;6186.566940314135;6191.597546159485;5973.522118230444;6243.656598886923;6269.592476489013;6280.309165991828;6293.622382656872;5242.580593552583;5991.460768530853;6048.425399587032;6105.186826067751;6133.824358648169;5981.461668449861;6041.879162416815;6046.909296360646;6047.183630209865;6070.9089363658695;5884.176215329771;5926.733297001731;5939.91090133657;5943.673097979653;5959.970200148971;5880.470757631833;5954.255718035246;6048.243969503812;6114.236541168587;6125.204929265209;5940.8811823764145;5962.52299816005;5963.463288304073;5966.343702192842;5979.940200598112 16:27:31 INFO - PROCESS | 1957 | |1;ext.html;493.814819442709;566.306274813354;586.557149352239;630.7540059376843;642.723628839599;30308.54537181941;30889.691103088964;30926.53610195849;38788.99999999993;38967.41548876762;41263.58736412635;41928.37107443391;42033.369499457534;42063;42133.7893310533;9751.12239898409;9854.655087071955;9859.30984831062;9862.753431164207;9875.753106172331;9656.75858103546;9789.657361992331;9795.412275263507;9800.31397802154;9801.16690081344;9700.272479564026;9809.166220871235;9829.852552211687;9931.205503559733;9932.006799320046;9818.901810981906;9902.009799020112;9903.25725570585;9904.603815847357;9910.405375677447;9678.75803104921;9818.705438836847;9833.557489912972;9836.31145819793;9844.950775246078;40594.79702601468;40881.79559102185;41328.586714133075;41378.79310603458;41459.7927010363;3356.9496457553155;3396.3377141457427;3499.580050393969;3762.3792074307707;3842.7502212356385;28599.856005759746;29483.82064717409;29800;30016.099517014525;30045.69954300451;2710.5527587948163;2726.3047922779565;2768.280247135739;2808;2843.132844482432;427544.9999999969;431317;433244;433667;435962;44743.10513789706;45350.546494535294;45385.31922021172;45459.545404546196;64497.35502645007;45358.09283814305;45445.09109817785;45505;45580.669836365494;45624;15618.68762624741;15756.842431575767;15790.973586716827;15805.36778528869;15856.286467109008;10589.682309530726;12870.16343937641;12880.227186368847;12892.935535322264;13039.804402933774;14598.854011459749;14640.487582934758;14744.926275368554;14753.77869331961;14794.482193123189;6177.227846519185;6324.968375158095;6325.683715814191;6361.681915904186;6368.522360822957;832.6919039955255;938.3759799733238;963.4460185393427;986.4722373530127;1058.3015209961388;27389.31526711848;29053.854730726212;29400.970966016514;29583.408331833674;29820.701792982225;1062.3413483640193;1082.983755243672;1085.1102096281131;1104.1056744037355;1187.281694574787;14837.480688176078;14878.851211487963;14884.330205140795;15099.924500377429;15201.087934723952;504751;508644;511775;511827;512688;58872.705636471546;59360;59479.702601486715;59523.80952380928;59543;1337.3848029906158;1444.317370263652;1464.2312785787333;1470.5514817980404;1493.57433131557;28424;28785.42429151447;29094.854525727234;29130.126096217147;29186.416271674872;45150.77424612856;45664.08671826611;46044.769776150904;46060;46192.769036154605;356238;356904;357775.4222457742;358554;359842;28479.145625631263;32777.83611081929;33557.83221083879;33593.16017099592;33984;41225.79387103045;41390;41766.582334176266;42011.579884200764;42933.785331073144;35217.64782352144;36124.27751445009;36439.81780091082;37434.87695369143;37487.62512374841;35825;36032.4595131068;36069.27861442704;36874.44688329731;37016.88949331524;35868.461973069905;36047.27905441929;36515.26969460649;36826.71106511259;38053;30895.84552077225;31921.521177182825;31926.68073319237;31964;32048.359032818746;23231.651525226796;23989.76010239945;24630.261092167264;24986.750662467166;25295 16:27:31 INFO - PROCESS | 1957 | |2;jquery.html;360.38734151941696;362.8185907046477;365.5138665574785;369.34994409838674;374.9493818334524;19644.607107857835;20369.388918332435;21171.576568468623;22017.33947981559;22067.779322206774;17360.131993400344;19587.608247835036;21181;21544.461388465297;21562.921853907283;5673.6879471629145;5834.154047663086;5861.0915308127305;5872.559558033165;5874.060150375941;4086.9182616347657;5896.764129434818;6156.445919867211;6477.935220647781;6487.643179625119;6394.26465956414;6418.165638466993;6419.197600299963;6419.743210271584;6424.03639454081;6067.150598916155;6351.301356850743;6356.809295721089;6357.396047375515;6362.268339141012;3759.981200094009;5203.531682148625;5267.604929630293;5433.347998240197;5671.291088613923;13146.474141034347;13421.66445838862;13445.19328840263;21898.12407503698;25463.981440742347;2060.330392622389;2150.1077053022977;2360.268316821791;2434.6226334917937;2499.1877639766967;7981.96009019957;10170.542325595366;10246.948765256126;10335.689929302132;11811.114166437466;1707.39387517432;1752.6669932712744;1775.6626241014167;1782.9108544572719;1787.9910600446915;96577.92016313222;104779.42830857543;104971;106139.93860061455;106526.93473065247;10883.67348979532;10885.83671244932;10976.725581860357;11029.172812039129;11146.721331966766;13622.795658065137;13648;13667.248301343323;13668.384922678504;13673.726525469436;8294.3779216559;8451.45065570736;8460.450070745383;8582.013068497203;8590.742277731679;6563.409293163638;8626.913730862736;8639.438436501607;8713.477191368538;8716.08481109487;4237.851675191354;4360.781960902005;4366.978165109154;4397.31841564558;4408.493023302297;1718.871084668655;1795.3446991848143;1797.6224992751406;1802.2160360243074;1823.3618233618126;823.5593957232852;864.7708357285325;877.635781150828;935.9251259899191;945.3146468810057;14496.927515362355;17344.65310693779;17655.73516397255;19325.806741932684;20452.795472045385;938.558877327655;961.5000199896015;969.4474149734583;978.6574698855486;1003.678822776719;10791.352518848895;10882.455877206108;10972.341659500455;10976.737675167458;11008.614698485515;630683;634847;638370;649017;651811;117296;118216;118266.40866795783;118348.81651183378;118586;1009.9444530550891;1015.0255754475786;1028.943408112561;1029.5367084811865;1031.1132426113536;18030.90984545069;18149.18328675239;18300.084995749894;18352.541186470444;18698.878067316004;50310.2137248481;50609.24086138637;50717.23924141215;52725.7363713179;53520;70623;70688.23279418056;71362.6431867858;71581.841815818;74119.6294018548;7705.345045670956;7743.45795794289;7851.293383595504;7861.685532578633;8154.75535733929;10378.481075946323;11716.472758726048;12296.81554776697;12561.560345387868;12628.558000469939;10056.19550435978;10337;10639.734006649896;10920.836187457353;11139.498722557342;10359.792804144026;10664.51241995931;10685.946570267099;10986.395748233925;11060.115190784878;11250.043746281657;11277.605283815356;11358.375289359165;11363.147763917905;11389;7666.578338191453;7670.578118203553;7743.070831500031;7756.612169391621;7805.609719514116;8151.918480815116;10320.43237621938;10489.685309440729;10867.456627168453;10881.945590271998 16:27:31 INFO - PROCESS | 1957 | |3;mootools.html;1302.2251760202676;1592.243684249981;1633.2976819967416;1910.9140088696008;2036.928707495237;7937.9603101984485;8733.519656418894;8881.245094166987;8884.02275749667;8891.333150013743;8562.44344117632;8809.427387219826;8812.295016398688;8820.029796722356;8829.86755198671;2044.488877780555;2096.2601041135895;2434.342727463593;2494.3390001649577;2510.3724068982665;2465.9753402466013;2472.27068014936;2473.2332976777166;2473.9010439582394;2474.8886300116446;2430.173740928084;2475.10896077412;2498.837575557583;2499.7250302466714;2504.0860086068637;2431.914882979096;2442.7282627156737;2451.570975079354;2457.4225057111566;2475.4306509502826;2446.3150317911013;2471.1845091119885;2476.108600903673;2476.6904136982876;2497.250824752567;8909.599068041955;8970.86543701845;8994.280457563445;8998.05520420353;8999.865002024975;5373.59698022646;5491.752871120809;5497.835064948058;5543.805966791143;5546.112621980464;3549.2369140634887;3610.945835812465;3689.538807649044;3741.9522533690338;3745.793981331026;1045.3153184664056;1056.7252514346249;1067.5836423794726;1078.4499905048403;1079.87581428136;11927.403629818475;11932.761344773142;11933.16467847251;11961.700957476045;11974.34141122238;4550.772461376984;4626.167289887785;4719.1741445247635;4762.690425122356;4763.737994410271;9513.571889265;9545.188658964065;9545.713628591153;9553.904460955302;9555.378900371454;5383.353997520244;5419.132938729785;5422.0511410503;5426.104692725735;5428.864278392993;4480.574345437179;4640.561425957964;4896.996115796253;4947.950520494821;5015.724135172528;3815.21788033458;3876.7092468064443;3921.941170882439;3948.881533553998;3957.2085582883537;1301.6290357248138;1305.6996890715;1308.9607311780662;1314.822498962647;1323.503686117706;1357.2806412601337;1363.5432130236284;1378.131776980496;1382.1154461144874;1418;8267.421280510307;8311.376646751518;8360.540170290571;8370.748877533684;8372.372072094617;517.6581107925338;525.8291055407008;533.0458479322048;537.8332716857786;538.5045757902739;6276.184096067574;6283.403076707706;6305.432511074026;6346.238451385863;6353.682315884187;9830;11042.447877606088;11064.778704425866;11067.114630829676;11087.445627718744;10547.947260263803;10814.78370432587;10817.972292632187;10868.45657717111;10965;8362.623681934327;8424.452410593292;8470.576471176417;8489.193526614961;8561.315094792402;7827.843443130992;8056.758297251092;8073;8208.794780130545;8218.260356567938;9222.861657075015;9363.157315841607;9509.809803803746;9538.093881081564;9573.808523829624;9618.086281803218;9815.705528834147;9960.900390995997;9981.800363992825;9993.600255989679;6730.764423245163;7276.381507571704;7481.812954675959;7485.1017877855;7577.014988051518;8243.05204901444;8293.62678679473;8307.376946728898;8315.584220789058;8330;7171.426285897011;7265.7093716252875;7273.672684729306;7409.740659076906;7426.702931882664;5783.652980821164;7013.368796808311;7031.191412987572;7115.501914865909;7303.452241081834;7317.26827317264;7453.478256521991;7489.73785917512;7516.661750221144;7541.924580754342;6745.2242992056545;6775.186977562724;6807.0810440589885;6857.211420686485;6859.485538584527;6884.93115068863;6899.48253880971;6942.375186233263;6963.7214511421;6964.79105626832 16:27:31 INFO - PROCESS | 1957 | |4;prototype.html;329.8350824587706;329.9026787097806;335.2858411583327;337.68639990437197;341.6719948849105;6104.450599446049;6443.516736244777;6478.125453063835;6481.4490768284695;6515.2833188349305;6466.094746735461;6474.870502589945;6493.870122597546;6509.414152726254;6526.6736663166885;3675.926481470369;4318;4570.840020599279;4645.27998160284;4836.733979631119;3983.541892682335;4702.694324868872;4747.643926705494;4789.425268967729;4802.351682522867;4324.659355599759;4329.870103896888;4758.428988521382;4771.9761401192945;4784.976075119637;4535.319702044703;4561.1105834362315;4676.994446194085;4683.508231635663;4769.5707386335225;4080.6327430531096;4082.4080508326424;4092.9795351023054;4097.180563887205;4097.364908439196;4903.7057776533165;6114.938850611481;6155.815325540241;6162.490189903458;6182.721777520022;5537.36320323164;5567.66594004361;5567.916481252784;5580.553555715533;5580.748866301026;6827.965860170667;6833.111695479605;6833.692483838189;6836.042953986446;6836.077129587492;4291.613754762056;4467;4500.707454015511;4522.773861306954;4599.103174880899;7195.856082878366;7199.6040217788;7253.637318134125;7261.056062711867;7272;4552.772361381918;4556.772161391984;4562.977185114053;4566.794494247767;4568.200564901195;4014.2573623879675;4616.746078965622;4623.976880115578;4637.1421287062;4646.7444290564345;5469.671819690831;5475.370332411744;5479.808206712746;5481;5485.835424937259;6577.6053436793945;6881.10545629065;6897.620630865351;6902.723891044402;6914.1702995639835;1587.8729701623843;1593.5697361712273;1605.8233594304618;1606.5100144455819;1607.3490236454254;950.9096635819586;954.8519979403204;1012.6405126180247;1017.2472370445964;1034.1623285139062;6146.108814222002;6340.334264902119;6341.651209183539;6381.266154392304;6382.8723425531225;7182.856342873113;7189.820254493575;7196.96401517989;7235.059442272576;7238.203797582261;6408.487321014308;6425.5502114851515;6437.2918978912285;6439.162908821823;6450.612963222222;3759.154190307159;3771.6605505504635;3774.169682669808;3788.8484460621266;3795.2978698940233;6052.334243233241;7209.279072092749;7499.437542184358;7532.472726909174;7551.509151905108;7315.4147668186415;7345;7361.1166660001145;7368;7368.410527157815;7436.330730234305;7483.850322993619;7520.9623951880985;7524.172341042481;7533.20901305377;7205.279472052753;7205.901462371231;7213.134423868959;7230.783076507713;7240.239774823568;5682.573806964577;6807.149106361705;7007.369336759716;7092.9645351772915;7101.786946391617;7427.665755040928;7477.476576639583;7490.951266822758;7610.771676849703;7783.104942931409;4555.4988951216;4607.7004994675235;4616.907661846677;4622.399088118523;4624.329472226441;7207.531510451804;7209.495335326476;7210.423166146591;7227.457940654577;7229.1325040993315;6730.293319201609;6950.679370919509;6971.721131154697;6988.860222795617;6989.679902046487;5572.0527510324155;6929.3070692930305;6933.479989000946;6943.166819981635;6948.965255173894;6819.352161544645;6820.35206655367;6833.692483838338;6837.008633748178;6844.349786770249;5606.467385598362;6061.848453788691;6612.94192929129;6975.476839236976;6978.337057979484;6475.222973243241;6490.123833282447;6775.796726098225;6790.422814060663;6810.761623343357 16:27:31 INFO - PROCESS | 1957 | |5;yui.html;664.8570557330173;675.9966200168999;676.5399528320742;704.7322017633298;737.9003834482344;15190.240487975598;15395.384184632629;15422.845771542281;15426.69146617067;15434;13875.583732488016;13949.860501394984;14039;14074.71850562988;14079;736.8047467421138;749.4304328710192;908.8364094463011;908.9590968406437;926.5089502563618;915.3135148638521;916.1525588830306;924.9871390827034;926.3006430145265;928.9628414863431;952.7808604021079;959.7120863740885;961.2550273537994;961.423146112334;962.37445660321;773.5397438524097;844.307667712476;958.3387462650784;974.1232890398697;976.6386437018277;607.271274470637;726.96728647211;727.3054233207274;729.0485915879775;730.5324592260957;14087.436502539886;14167.362468688934;14171.503997360043;14180.645483862883;14202.50291239812;12373.938130309381;12396.504139834396;12664.81002784959;12740.554080607228;12869.871301287054;9996.800063998679;10004.849927251096;10074.345167564084;10237.692869213935;10856.470331176417;3288.112209703391;3466.959912026382;3643.453481977698;3651.1054791575966;3723.646253605903;80877.78683319755;82114.17885821125;82209.58895205485;82308;82617;9523.999980002138;9528.142467177988;9532.571034303473;9807.950960245296;9921.652742154134;22337.553248935255;22354;22401.43996400103;22409.32772016842;22427.88786056092;7249.528780629243;7479.887801682979;7495.287947644965;7521.247875212544;7581.12817026038;3455.94816077759;3566.589842168132;4107.691923105779;4137.007118291588;4215.346621273708;3523.8061906595385;3589.1565482111682;3593.1735700788963;3593.7664051836546;3598.1544337080763;638.2628064585411;643.8905386084283;646.2632598837329;650.4763665249519;651.2575663743337;561.2507302750791;562.5387182510302;589.2163422647868;613.8437128123796;629.8425393651587;7789.883151752728;8113.594320283963;8178.223068808454;8330.541820199947;8333.166683331618;537.1968906484752;551.6359202926129;572.7880684146809;626.8088233088861;641.0832509511444;3463.8915547024712;3724.9627503724614;3752.5309336332957;3870.9419358709642;4012.4382586437923;80913;85061.14938850656;88020;89768;91495;75799;76016;76856.15719214016;78150;78368.21631783723;67015.32984670092;67437.6628116866;68760;69972.65013674898;70230.94653580303;7584.2794934481135;7625.3514818223475;7764.5729484878875;7777.688892444239;7849.60751962411;44227.11545769002;44369;44552.77723611361;44810.327845081694;45647.63057108292;60462.39537604568;62530.687346562976;62732.37267627265;63027;63501.41246468875;10019.92399918114;10117.342372745748;10161.237907157141;10345.068943795095;10407.791844163226;10949.726256843642;10976.670699879016;11312.81450676408;11575.363355015219;11820.172587919107;8371.279901514255;10557;11080.667579972614;11110.277831940897;11592.304461732323;11047.502862371373;11082.667519974091;11137.053350465301;11163.776724465628;11504.079673626256;10427.895721042996;10562.366258024544;10579.788404232026;11138.888611113785;11323;9356;9563.234941204826;9685.806283874424;9722.80554388894;9797.363171393836;9501;9553.570089346134;9618.663346782829;9650.855237171307;9654.758631034 16:27:31 INFO - PROCESS | 1957 | __end_tp_report 16:27:31 INFO - PROCESS | 1957 | __start_cc_report 16:27:31 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,1250 16:27:31 INFO - PROCESS | 1957 | __end_cc_report 16:27:31 INFO - PROCESS | 1957 | __startTimestamp1459294051419__endTimestamp 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | ------- Summary: start ------- 16:27:31 INFO - PROCESS | 1957 | Number of tests: 6 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#0] dojo.html Cycles:165 Average:5699.15 Median:5940.88 stddev:645.46 (10.9%) stddev-sans-first:622.46 16:27:31 INFO - PROCESS | 1957 | Values: 3432.6 3452.4 3470.4 3496.7 3531.9 5544.2 5641.5 5666.2 5693.9 5706.0 5634.0 5687.9 5762.0 5775.5 5795.2 4223.9 5077.1 5120.6 5149.3 5239.1 5231.8 5233.8 5255.1 5278.1 5296.6 5056.3 5144.5 5154.9 5206.2 5211.3 5140.0 5168.9 5171.1 5175.0 5175.2 5095.8 5122.7 5146.5 5156.2 5161.0 5580.0 5586.1 5590.5 5594.4 5596.6 6110.1 6205.4 6228.8 6243.1 6245.1 6140.2 6255.1 6303.7 6318.1 6322.8 4913.6 5795.0 5806.8 5811.2 5828.0 6224.1 6267.2 6272.0 6276.4 6287.1 6000.4 6057.7 6132.7 6133.3 6154.0 6224.9 6275.2 6279.8 6300.1 6302.4 6200.4 6203.4 6211.2 6218.7 6232.3 6051.9 6099.9 6131.5 6170.7 6220.5 4831.7 4855.9 4863.1 4884.4 4900.7 4344.5 4352.6 4359.9 4372.6 4415.1 5575.3 5678.9 5697.3 5721.3 5747.7 5137.6 6261.1 6276.3 6279.6 6284.3 5655.6 5655.7 5677.9 5683.6 5688.4 5289.3 5325.0 5366.6 5396.8 5406.5 6272.6 6298.6 6310.9 6311.4 6313.9 6185.7 6286.4 6288.5 6309.1 6313.1 5161.9 6138.7 6263.9 6278.4 6294.3 6165.0 6179.4 6179.7 6186.6 6191.6 5973.5 6243.7 6269.6 6280.3 6293.6 5242.6 5991.5 6048.4 6105.2 6133.8 5981.5 6041.9 6046.9 6047.2 6070.9 5884.2 5926.7 5939.9 5943.7 5960.0 5880.5 5954.3 6048.2 6114.2 6125.2 5940.9 5962.5 5963.5 5966.3 5979.9 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#1] ext.html Cycles:180 Average:57453.99 Median:20625.00 stddev:116196.60 (563.4%) stddev-sans-first:116443.86 16:27:31 INFO - PROCESS | 1957 | Values: 493.8 566.3 586.6 630.8 642.7 30308.5 30889.7 30926.5 38789.0 38967.4 41263.6 41928.4 42033.4 42063.0 42133.8 9751.1 9854.7 9859.3 9862.8 9875.8 9656.8 9789.7 9795.4 9800.3 9801.2 9700.3 9809.2 9829.9 9931.2 9932.0 9818.9 9902.0 9903.3 9904.6 9910.4 9678.8 9818.7 9833.6 9836.3 9845.0 40594.8 40881.8 41328.6 41378.8 41459.8 3356.9 3396.3 3499.6 3762.4 3842.8 28599.9 29483.8 29800.0 30016.1 30045.7 2710.6 2726.3 2768.3 2808.0 2843.1 427545.0 431317.0 433244.0 433667.0 435962.0 44743.1 45350.5 45385.3 45459.5 64497.4 45358.1 45445.1 45505.0 45580.7 45624.0 15618.7 15756.8 15791.0 15805.4 15856.3 10589.7 12870.2 12880.2 12892.9 13039.8 14598.9 14640.5 14744.9 14753.8 14794.5 6177.2 6325.0 6325.7 6361.7 6368.5 832.7 938.4 963.4 986.5 1058.3 27389.3 29053.9 29401.0 29583.4 29820.7 1062.3 1083.0 1085.1 1104.1 1187.3 14837.5 14878.9 14884.3 15099.9 15201.1 504751.0 508644.0 511775.0 511827.0 512688.0 58872.7 59360.0 59479.7 59523.8 59543.0 1337.4 1444.3 1464.2 1470.6 1493.6 28424.0 28785.4 29094.9 29130.1 29186.4 45150.8 45664.1 46044.8 46060.0 46192.8 356238.0 356904.0 357775.4 358554.0 359842.0 28479.1 32777.8 33557.8 33593.2 33984.0 41225.8 41390.0 41766.6 42011.6 42933.8 35217.6 36124.3 36439.8 37434.9 37487.6 35825.0 36032.5 36069.3 36874.4 37016.9 35868.5 36047.3 36515.3 36826.7 38053.0 30895.8 31921.5 31926.7 31964.0 32048.4 23231.7 23989.8 24630.3 24986.8 25295.0 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#2] jquery.html Cycles:180 Average:34908.54 Median:21730.52 stddev:106099.78 (488.3%) stddev-sans-first:106365.70 16:27:31 INFO - PROCESS | 1957 | Values: 360.4 362.8 365.5 369.3 374.9 19644.6 20369.4 21171.6 22017.3 22067.8 17360.1 19587.6 21181.0 21544.5 21562.9 5673.7 5834.2 5861.1 5872.6 5874.1 4086.9 5896.8 6156.4 6477.9 6487.6 6394.3 6418.2 6419.2 6419.7 6424.0 6067.2 6351.3 6356.8 6357.4 6362.3 3760.0 5203.5 5267.6 5433.3 5671.3 13146.5 13421.7 13445.2 21898.1 25464.0 2060.3 2150.1 2360.3 2434.6 2499.2 7982.0 10170.5 10246.9 10335.7 11811.1 1707.4 1752.7 1775.7 1782.9 1788.0 96577.9 104779.4 104971.0 106139.9 106526.9 10883.7 10885.8 10976.7 11029.2 11146.7 13622.8 13648.0 13667.2 13668.4 13673.7 8294.4 8451.5 8460.5 8582.0 8590.7 6563.4 8626.9 8639.4 8713.5 8716.1 4237.9 4360.8 4367.0 4397.3 4408.5 1718.9 1795.3 1797.6 1802.2 1823.4 823.6 864.8 877.6 935.9 945.3 14496.9 17344.7 17655.7 19325.8 20452.8 938.6 961.5 969.4 978.7 1003.7 10791.4 10882.5 10972.3 10976.7 11008.6 630683.0 634847.0 638370.0 649017.0 651811.0 117296.0 118216.0 118266.4 118348.8 118586.0 1009.9 1015.0 1028.9 1029.5 1031.1 18030.9 18149.2 18300.1 18352.5 18698.9 50310.2 50609.2 50717.2 52725.7 53520.0 70623.0 70688.2 71362.6 71581.8 74119.6 7705.3 7743.5 7851.3 7861.7 8154.8 10378.5 11716.5 12296.8 12561.6 12628.6 10056.2 10337.0 10639.7 10920.8 11139.5 10359.8 10664.5 10685.9 10986.4 11060.1 11250.0 11277.6 11358.4 11363.1 11389.0 7666.6 7670.6 7743.1 7756.6 7805.6 8151.9 10320.4 10489.7 10867.5 10881.9 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#3] mootools.html Cycles:180 Average:6031.30 Median:5494.79 stddev:3205.54 (58.3%) stddev-sans-first:3194.82 16:27:31 INFO - PROCESS | 1957 | Values: 1302.2 1592.2 1633.3 1910.9 2036.9 7938.0 8733.5 8881.2 8884.0 8891.3 8562.4 8809.4 8812.3 8820.0 8829.9 2044.5 2096.3 2434.3 2494.3 2510.4 2466.0 2472.3 2473.2 2473.9 2474.9 2430.2 2475.1 2498.8 2499.7 2504.1 2431.9 2442.7 2451.6 2457.4 2475.4 2446.3 2471.2 2476.1 2476.7 2497.3 8909.6 8970.9 8994.3 8998.1 8999.9 5373.6 5491.8 5497.8 5543.8 5546.1 3549.2 3610.9 3689.5 3742.0 3745.8 1045.3 1056.7 1067.6 1078.4 1079.9 11927.4 11932.8 11933.2 11961.7 11974.3 4550.8 4626.2 4719.2 4762.7 4763.7 9513.6 9545.2 9545.7 9553.9 9555.4 5383.4 5419.1 5422.1 5426.1 5428.9 4480.6 4640.6 4897.0 4948.0 5015.7 3815.2 3876.7 3921.9 3948.9 3957.2 1301.6 1305.7 1309.0 1314.8 1323.5 1357.3 1363.5 1378.1 1382.1 1418.0 8267.4 8311.4 8360.5 8370.7 8372.4 517.7 525.8 533.0 537.8 538.5 6276.2 6283.4 6305.4 6346.2 6353.7 9830.0 11042.4 11064.8 11067.1 11087.4 10547.9 10814.8 10818.0 10868.5 10965.0 8362.6 8424.5 8470.6 8489.2 8561.3 7827.8 8056.8 8073.0 8208.8 8218.3 9222.9 9363.2 9509.8 9538.1 9573.8 9618.1 9815.7 9960.9 9981.8 9993.6 6730.8 7276.4 7481.8 7485.1 7577.0 8243.1 8293.6 8307.4 8315.6 8330.0 7171.4 7265.7 7273.7 7409.7 7426.7 5783.7 7013.4 7031.2 7115.5 7303.5 7317.3 7453.5 7489.7 7516.7 7541.9 6745.2 6775.2 6807.1 6857.2 6859.5 6884.9 6899.5 6942.4 6963.7 6964.8 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#4] prototype.html Cycles:180 Average:5616.77 Median:6431.42 stddev:1816.84 (28.2%) stddev-sans-first:1778.07 16:27:31 INFO - PROCESS | 1957 | Values: 329.8 329.9 335.3 337.7 341.7 6104.5 6443.5 6478.1 6481.4 6515.3 6466.1 6474.9 6493.9 6509.4 6526.7 3675.9 4318.0 4570.8 4645.3 4836.7 3983.5 4702.7 4747.6 4789.4 4802.4 4324.7 4329.9 4758.4 4772.0 4785.0 4535.3 4561.1 4677.0 4683.5 4769.6 4080.6 4082.4 4093.0 4097.2 4097.4 4903.7 6114.9 6155.8 6162.5 6182.7 5537.4 5567.7 5567.9 5580.6 5580.7 6828.0 6833.1 6833.7 6836.0 6836.1 4291.6 4467.0 4500.7 4522.8 4599.1 7195.9 7199.6 7253.6 7261.1 7272.0 4552.8 4556.8 4563.0 4566.8 4568.2 4014.3 4616.7 4624.0 4637.1 4646.7 5469.7 5475.4 5479.8 5481.0 5485.8 6577.6 6881.1 6897.6 6902.7 6914.2 1587.9 1593.6 1605.8 1606.5 1607.3 950.9 954.9 1012.6 1017.2 1034.2 6146.1 6340.3 6341.7 6381.3 6382.9 7182.9 7189.8 7197.0 7235.1 7238.2 6408.5 6425.6 6437.3 6439.2 6450.6 3759.2 3771.7 3774.2 3788.8 3795.3 6052.3 7209.3 7499.4 7532.5 7551.5 7315.4 7345.0 7361.1 7368.0 7368.4 7436.3 7483.9 7521.0 7524.2 7533.2 7205.3 7205.9 7213.1 7230.8 7240.2 5682.6 6807.1 7007.4 7093.0 7101.8 7427.7 7477.5 7491.0 7610.8 7783.1 4555.5 4607.7 4616.9 4622.4 4624.3 7207.5 7209.5 7210.4 7227.5 7229.1 6730.3 6950.7 6971.7 6988.9 6989.7 5572.1 6929.3 6933.5 6943.2 6949.0 6819.4 6820.4 6833.7 6837.0 6844.3 5606.5 6061.8 6612.9 6975.5 6978.3 6475.2 6490.1 6775.8 6790.4 6810.8 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - PROCESS | 1957 | [#5] yui.html Cycles:180 Average:17741.07 Median:31828.42 stddev:24818.67 (78.0%) stddev-sans-first:24855.17 16:27:31 INFO - PROCESS | 1957 | Values: 664.9 676.0 676.5 704.7 737.9 15190.2 15395.4 15422.8 15426.7 15434.0 13875.6 13949.9 14039.0 14074.7 14079.0 736.8 749.4 908.8 909.0 926.5 915.3 916.2 925.0 926.3 929.0 952.8 959.7 961.3 961.4 962.4 773.5 844.3 958.3 974.1 976.6 607.3 727.0 727.3 729.0 730.5 14087.4 14167.4 14171.5 14180.6 14202.5 12373.9 12396.5 12664.8 12740.6 12869.9 9996.8 10004.8 10074.3 10237.7 10856.5 3288.1 3467.0 3643.5 3651.1 3723.6 80877.8 82114.2 82209.6 82308.0 82617.0 9524.0 9528.1 9532.6 9808.0 9921.7 22337.6 22354.0 22401.4 22409.3 22427.9 7249.5 7479.9 7495.3 7521.2 7581.1 3455.9 3566.6 4107.7 4137.0 4215.3 3523.8 3589.2 3593.2 3593.8 3598.2 638.3 643.9 646.3 650.5 651.3 561.3 562.5 589.2 613.8 629.8 7789.9 8113.6 8178.2 8330.5 8333.2 537.2 551.6 572.8 626.8 641.1 3463.9 3725.0 3752.5 3870.9 4012.4 80913.0 85061.1 88020.0 89768.0 91495.0 75799.0 76016.0 76856.2 78150.0 78368.2 67015.3 67437.7 68760.0 69972.7 70230.9 7584.3 7625.4 7764.6 7777.7 7849.6 44227.1 44369.0 44552.8 44810.3 45647.6 60462.4 62530.7 62732.4 63027.0 63501.4 10019.9 10117.3 10161.2 10345.1 10407.8 10949.7 10976.7 11312.8 11575.4 11820.2 8371.3 10557.0 11080.7 11110.3 11592.3 11047.5 11082.7 11137.1 11163.8 11504.1 10427.9 10562.4 10579.8 11138.9 11323.0 9356.0 9563.2 9685.8 9722.8 9797.4 9501.0 9553.6 9618.7 9650.9 9654.8 16:27:31 INFO - PROCESS | 1957 | -------- Summary: end -------- 16:27:31 INFO - PROCESS | 1957 | 16:27:31 INFO - TEST-INFO | 1957: exit 0 16:27:31 INFO - TEST-OK | dromaeo_css | took 1113684ms 16:27:31 INFO - TEST-START | kraken 16:27:31 INFO - operating with platform_type : mac_ 16:27:31 INFO - Initialising browser for kraken test... 16:27:32 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3jxyyb/profile http://localhost:49483/getInfo.html) 16:27:34 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 16:27:34 INFO - PROCESS | 1961 | colorDepth:24 16:27:34 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 16:27:34 INFO - PROCESS | 1961 | __metrics 16:27:34 INFO - PROCESS | 1961 | 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:27:34 ERROR - PROCESS | 1961 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:27:35 INFO - TEST-INFO | 1961: exit 0 16:27:35 INFO - Browser initialized. 16:27:35 INFO - Running cycle 1/1 for kraken test... 16:27:35 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp3jxyyb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:27:47 INFO - PROCESS | 1963 | RSS: Main: 244219904 16:27:47 INFO - PROCESS | 1963 | 16:27:49 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49483/tests/kraken/driver.html?testName=audio-beat-detection) 16:27:50 INFO - PROCESS | 1963 | RSS: Main: 290861056 16:27:50 INFO - PROCESS | 1963 | 16:27:52 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49483/tests/kraken/driver.html?testName=audio-dft) 16:27:53 INFO - PROCESS | 1963 | RSS: Main: 300752896 16:27:53 INFO - PROCESS | 1963 | 16:27:56 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49483/tests/kraken/driver.html?testName=audio-fft) 16:27:57 INFO - PROCESS | 1963 | RSS: Main: 286130176 16:27:57 INFO - PROCESS | 1963 | 16:27:59 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49483/tests/kraken/driver.html?testName=audio-oscillator) 16:27:59 INFO - PROCESS | 1963 | RSS: Main: 287612928 16:27:59 INFO - PROCESS | 1963 | 16:28:01 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:28:02 INFO - PROCESS | 1963 | RSS: Main: 288137216 16:28:02 INFO - PROCESS | 1963 | 16:28:05 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49483/tests/kraken/driver.html?testName=imaging-darkroom) 16:28:05 INFO - PROCESS | 1963 | RSS: Main: 288178176 16:28:05 INFO - PROCESS | 1963 | 16:28:08 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49483/tests/kraken/driver.html?testName=imaging-desaturate) 16:28:09 INFO - PROCESS | 1963 | RSS: Main: 288362496 16:28:09 INFO - PROCESS | 1963 | 16:28:12 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49483/tests/kraken/driver.html?testName=json-parse-financial) 16:28:12 INFO - PROCESS | 1963 | RSS: Main: 288841728 16:28:12 INFO - PROCESS | 1963 | 16:28:14 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:28:14 INFO - PROCESS | 1963 | RSS: Main: 324366336 16:28:14 INFO - PROCESS | 1963 | 16:28:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:28:17 INFO - PROCESS | 1963 | RSS: Main: 323678208 16:28:17 INFO - PROCESS | 1963 | 16:28:19 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:28:20 INFO - PROCESS | 1963 | RSS: Main: 331509760 16:28:20 INFO - PROCESS | 1963 | 16:28:22 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:28:23 INFO - PROCESS | 1963 | RSS: Main: 332468224 16:28:23 INFO - PROCESS | 1963 | 16:28:25 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:28:26 INFO - PROCESS | 1963 | RSS: Main: 332636160 16:28:26 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49483/tests/kraken/driver.html?testName=ai-astar) 16:28:28 INFO - PROCESS | 1963 | RSS: Main: 394981376 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | __start_tp_report 16:28:28 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 16:28:28 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 16:28:28 INFO - PROCESS | 1963 | |i|pagename|runs| 16:28:28 INFO - PROCESS | 1963 | |0;ai-astar;112;108;111;111;111;110;118;110;111;111 16:28:28 INFO - PROCESS | 1963 | |1;audio-beat-detection;155;120;145;158;116;141;139;117;162;120 16:28:28 INFO - PROCESS | 1963 | |2;audio-dft;188;186;184;185;185;185;185;185;181;182 16:28:28 INFO - PROCESS | 1963 | |3;audio-fft;78;73;87;80;56;60;57;77;80;64 16:28:28 INFO - PROCESS | 1963 | |4;audio-oscillator;96;92;135;80;77;85;117;79;80;119 16:28:28 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;88;85;88;86;88;86;88;85;87;84 16:28:28 INFO - PROCESS | 1963 | |6;imaging-darkroom;94;93;110;128;141;149;94;95;119;102 16:28:28 INFO - PROCESS | 1963 | |7;imaging-desaturate;87;85;85;84;86;85;85;87;84;84 16:28:28 INFO - PROCESS | 1963 | |8;json-parse-financial;54;55;55;54;55;53;54;63;55;52 16:28:28 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;62;67;78;72;71;69;67;67;66;69 16:28:28 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;83;85;82;83;83;83;82;83;85;81 16:28:28 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;130;140;135;137;132;122;125;125;141;130 16:28:28 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;141;130;141;141;138;127;139;137;138;138 16:28:28 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;70;66;66;67;69;66;67;66;66;66 16:28:28 INFO - PROCESS | 1963 | __end_tp_report 16:28:28 INFO - PROCESS | 1963 | __start_cc_report 16:28:28 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1275 16:28:28 INFO - PROCESS | 1963 | __end_cc_report 16:28:28 INFO - PROCESS | 1963 | __startTimestamp1459294108424__endTimestamp 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | ------- Summary: start ------- 16:28:28 INFO - PROCESS | 1963 | Number of tests: 14 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:2.73 16:28:28 INFO - PROCESS | 1963 | Values: 112.0 108.0 111.0 111.0 111.0 110.0 118.0 110.0 111.0 111.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:143.00 stddev:17.93 (12.5%) stddev-sans-first:17.83 16:28:28 INFO - PROCESS | 1963 | Values: 155.0 120.0 145.0 158.0 116.0 141.0 139.0 117.0 162.0 120.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:1.96 (1.1%) stddev-sans-first:1.64 16:28:28 INFO - PROCESS | 1963 | Values: 188.0 186.0 184.0 185.0 185.0 185.0 185.0 185.0 181.0 182.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:71.20 Median:77.50 stddev:11.04 (14.2%) stddev-sans-first:11.44 16:28:28 INFO - PROCESS | 1963 | Values: 78.0 73.0 87.0 80.0 56.0 60.0 57.0 77.0 80.0 64.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:80.00 stddev:20.52 (25.7%) stddev-sans-first:21.77 16:28:28 INFO - PROCESS | 1963 | Values: 96.0 92.0 135.0 80.0 77.0 85.0 117.0 79.0 80.0 119.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.51 (1.7%) stddev-sans-first:1.50 16:28:28 INFO - PROCESS | 1963 | Values: 88.0 85.0 88.0 86.0 88.0 86.0 88.0 85.0 87.0 84.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:121.00 stddev:20.86 (17.2%) stddev-sans-first:21.02 16:28:28 INFO - PROCESS | 1963 | Values: 94.0 93.0 110.0 128.0 141.0 149.0 94.0 95.0 119.0 102.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 16:28:28 INFO - PROCESS | 1963 | Values: 87.0 85.0 85.0 84.0 86.0 85.0 85.0 87.0 84.0 84.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.98 (5.4%) stddev-sans-first:3.14 16:28:28 INFO - PROCESS | 1963 | Values: 54.0 55.0 55.0 54.0 55.0 53.0 54.0 63.0 55.0 52.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:4.26 (6.2%) stddev-sans-first:3.75 16:28:28 INFO - PROCESS | 1963 | Values: 62.0 67.0 78.0 72.0 71.0 69.0 67.0 67.0 66.0 69.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 16:28:28 INFO - PROCESS | 1963 | Values: 83.0 85.0 82.0 83.0 83.0 83.0 82.0 83.0 85.0 81.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:133.50 stddev:6.53 (4.9%) stddev-sans-first:6.90 16:28:28 INFO - PROCESS | 1963 | Values: 130.0 140.0 135.0 137.0 132.0 122.0 125.0 125.0 141.0 130.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:138.50 stddev:4.76 (3.4%) stddev-sans-first:4.82 16:28:28 INFO - PROCESS | 1963 | Values: 141.0 130.0 141.0 141.0 138.0 127.0 139.0 137.0 138.0 138.0 16:28:28 INFO - PROCESS | 1963 | 16:28:28 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.01 16:28:28 INFO - PROCESS | 1963 | Values: 70.0 66.0 66.0 67.0 69.0 66.0 67.0 66.0 66.0 66.0 16:28:28 INFO - PROCESS | 1963 | -------- Summary: end -------- 16:28:28 INFO - PROCESS | 1963 | 16:28:29 INFO - TEST-INFO | 1963: exit 0 16:28:29 INFO - TEST-OK | kraken | took 57170ms 16:28:29 INFO - SUITE-END | took 1170s 16:28:29 INFO - Completed test suite (00:19:31) 16:28:29 INFO - javascript benchmark 16:28:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3432.5537680101593, 3452.361313157066, 3470.357983773002, 3496.6852983231506, 3531.9117022074447, 5544.22380866679, 5641.548676105912, 5666.178404131399, 5693.943060569393, 5706.0014497462935, 5634.0, 5687.857803554903, 5762.049261871786, 5775.509081728048, 5795.21764561784, 4223.936640950388, 5077.136886729265, 5120.641555091126, 5149.253358263069, 5239.083160446926, 5231.816886408977, 5233.816816411427, 5255.05409026377, 5278.076336641092, 5296.576273898079, 5056.292119103328, 5144.536991670768, 5154.871128221787, 5206.193040078794, 5211.270422140884, 5139.974300128512, 5168.8966220675375, 5171.095058364809, 5174.974125129388, 5175.223716442564, 5095.847124586268, 5122.718250496221, 5146.459621739738, 5156.1750119980625, 5161.0, 5579.995600791855, 5586.13414920688, 5590.496855283044, 5594.356648985378, 5596.552275817925, 6110.052941793984, 6205.410486003822, 6228.750849965996, 6243.063540468921, 6245.094461303131, 6140.171076904606, 6255.06174073888, 6303.684815759239, 6318.115463835067, 6322.841928951767, 4913.631477639191, 5794.971025144847, 5806.796762113306, 5811.186433899215, 5828.03837366834, 6224.097505861625, 6267.2165979252595, 6272.0, 6276.403741644536, 6287.1198032275515, 6000.406236221412, 6057.727402266909, 6132.724027418777, 6133.304060594615, 6154.046122850965, 6224.9377506224355, 6275.152854364603, 6279.811605651837, 6300.054991751274, 6302.432781049728, 6200.441960223601, 6203.379662033761, 6211.223597050369, 6218.657973811393, 6232.252129744369, 6051.939480605226, 6099.897739344564, 6131.468419844996, 6170.691465426711, 6220.471259942956, 4831.661783675179, 4855.854324370274, 4863.148948933923, 4884.438289596671, 4900.681455705368, 4344.500382455994, 4352.586504282088, 4359.934600980988, 4372.562743725665, 4415.094905544356, 5575.275214222206, 5678.914816277759, 5697.287839020122, 5721.342045664802, 5747.741351639186, 5137.588992880561, 6261.092141639437, 6276.309605943343, 6279.623222606567, 6284.308726040132, 5655.604107712503, 5655.688937108499, 5677.858053548612, 5683.60214784961, 5688.402717714663, 5289.259503669489, 5325.0, 5366.597505187126, 5396.811111611075, 5406.54044406222, 6272.6236425814595, 6298.622082675054, 6310.873782524232, 6311.431971122621, 6313.90529142054, 6185.690715464299, 6286.402791734778, 6288.496920246461, 6309.085182648582, 6313.05304204373, 5161.896762064813, 6138.664296166039, 6263.906041409474, 6278.372162783685, 6294.276158241861, 6165.0, 6179.412955769195, 6179.721912514037, 6186.566940314135, 6191.597546159485, 5973.522118230444, 6243.656598886923, 6269.592476489013, 6280.309165991828, 6293.622382656872, 5242.580593552583, 5991.460768530853, 6048.425399587032, 6105.186826067751, 6133.824358648169, 5981.461668449861, 6041.879162416815, 6046.909296360646, 6047.183630209865, 6070.9089363658695, 5884.176215329771, 5926.733297001731, 5939.91090133657, 5943.673097979653, 5959.970200148971, 5880.470757631833, 5954.255718035246, 6048.243969503812, 6114.236541168587, 6125.204929265209, 5940.8811823764145, 5962.52299816005, 5963.463288304073, 5966.343702192842, 5979.940200598112], "unit": "score", "name": "dojo.html", "value": 5659.414013186708}, {"lowerIsBetter": false, "replicates": [493.814819442709, 566.306274813354, 586.557149352239, 630.7540059376843, 642.723628839599, 30308.54537181941, 30889.691103088964, 30926.53610195849, 38788.99999999993, 38967.41548876762, 41263.58736412635, 41928.37107443391, 42033.369499457534, 42063.0, 42133.7893310533, 9751.12239898409, 9854.655087071955, 9859.30984831062, 9862.753431164207, 9875.753106172331, 9656.75858103546, 9789.657361992331, 9795.412275263507, 9800.31397802154, 9801.16690081344, 9700.272479564026, 9809.166220871235, 9829.852552211687, 9931.205503559733, 9932.006799320046, 9818.901810981906, 9902.009799020112, 9903.25725570585, 9904.603815847357, 9910.405375677447, 9678.75803104921, 9818.705438836847, 9833.557489912972, 9836.31145819793, 9844.950775246078, 40594.79702601468, 40881.79559102185, 41328.586714133075, 41378.79310603458, 41459.7927010363, 3356.9496457553155, 3396.3377141457427, 3499.580050393969, 3762.3792074307707, 3842.7502212356385, 28599.856005759746, 29483.82064717409, 29800.0, 30016.099517014525, 30045.69954300451, 2710.5527587948163, 2726.3047922779565, 2768.280247135739, 2808.0, 2843.132844482432, 427544.9999999969, 431317.0, 433244.0, 433667.0, 435962.0, 44743.10513789706, 45350.546494535294, 45385.31922021172, 45459.545404546196, 64497.35502645007, 45358.09283814305, 45445.09109817785, 45505.0, 45580.669836365494, 45624.0, 15618.68762624741, 15756.842431575767, 15790.973586716827, 15805.36778528869, 15856.286467109008, 10589.682309530726, 12870.16343937641, 12880.227186368847, 12892.935535322264, 13039.804402933774, 14598.854011459749, 14640.487582934758, 14744.926275368554, 14753.77869331961, 14794.482193123189, 6177.227846519185, 6324.968375158095, 6325.683715814191, 6361.681915904186, 6368.522360822957, 832.6919039955255, 938.3759799733238, 963.4460185393427, 986.4722373530127, 1058.3015209961388, 27389.31526711848, 29053.854730726212, 29400.970966016514, 29583.408331833674, 29820.701792982225, 1062.3413483640193, 1082.983755243672, 1085.1102096281131, 1104.1056744037355, 1187.281694574787, 14837.480688176078, 14878.851211487963, 14884.330205140795, 15099.924500377429, 15201.087934723952, 504751.0, 508644.0, 511775.0, 511827.0, 512688.0, 58872.705636471546, 59360.0, 59479.702601486715, 59523.80952380928, 59543.0, 1337.3848029906158, 1444.317370263652, 1464.2312785787333, 1470.5514817980404, 1493.57433131557, 28424.0, 28785.42429151447, 29094.854525727234, 29130.126096217147, 29186.416271674872, 45150.77424612856, 45664.08671826611, 46044.769776150904, 46060.0, 46192.769036154605, 356238.0, 356904.0, 357775.4222457742, 358554.0, 359842.0, 28479.145625631263, 32777.83611081929, 33557.83221083879, 33593.16017099592, 33984.0, 41225.79387103045, 41390.0, 41766.582334176266, 42011.579884200764, 42933.785331073144, 35217.64782352144, 36124.27751445009, 36439.81780091082, 37434.87695369143, 37487.62512374841, 35825.0, 36032.4595131068, 36069.27861442704, 36874.44688329731, 37016.88949331524, 35868.461973069905, 36047.27905441929, 36515.26969460649, 36826.71106511259, 38053.0, 30895.84552077225, 31921.521177182825, 31926.68073319237, 31964.0, 32048.359032818746, 23231.651525226796, 23989.76010239945, 24630.261092167264, 24986.750662467166, 25295.0], "unit": "score", "name": "ext.html", "value": 18835.518444790134}, {"lowerIsBetter": false, "replicates": [360.38734151941696, 362.8185907046477, 365.5138665574785, 369.34994409838674, 374.9493818334524, 19644.607107857835, 20369.388918332435, 21171.576568468623, 22017.33947981559, 22067.779322206774, 17360.131993400344, 19587.608247835036, 21181.0, 21544.461388465297, 21562.921853907283, 5673.6879471629145, 5834.154047663086, 5861.0915308127305, 5872.559558033165, 5874.060150375941, 4086.9182616347657, 5896.764129434818, 6156.445919867211, 6477.935220647781, 6487.643179625119, 6394.26465956414, 6418.165638466993, 6419.197600299963, 6419.743210271584, 6424.03639454081, 6067.150598916155, 6351.301356850743, 6356.809295721089, 6357.396047375515, 6362.268339141012, 3759.981200094009, 5203.531682148625, 5267.604929630293, 5433.347998240197, 5671.291088613923, 13146.474141034347, 13421.66445838862, 13445.19328840263, 21898.12407503698, 25463.981440742347, 2060.330392622389, 2150.1077053022977, 2360.268316821791, 2434.6226334917937, 2499.1877639766967, 7981.96009019957, 10170.542325595366, 10246.948765256126, 10335.689929302132, 11811.114166437466, 1707.39387517432, 1752.6669932712744, 1775.6626241014167, 1782.9108544572719, 1787.9910600446915, 96577.92016313222, 104779.42830857543, 104971.0, 106139.93860061455, 106526.93473065247, 10883.67348979532, 10885.83671244932, 10976.725581860357, 11029.172812039129, 11146.721331966766, 13622.795658065137, 13648.0, 13667.248301343323, 13668.384922678504, 13673.726525469436, 8294.3779216559, 8451.45065570736, 8460.450070745383, 8582.013068497203, 8590.742277731679, 6563.409293163638, 8626.913730862736, 8639.438436501607, 8713.477191368538, 8716.08481109487, 4237.851675191354, 4360.781960902005, 4366.978165109154, 4397.31841564558, 4408.493023302297, 1718.871084668655, 1795.3446991848143, 1797.6224992751406, 1802.2160360243074, 1823.3618233618126, 823.5593957232852, 864.7708357285325, 877.635781150828, 935.9251259899191, 945.3146468810057, 14496.927515362355, 17344.65310693779, 17655.73516397255, 19325.806741932684, 20452.795472045385, 938.558877327655, 961.5000199896015, 969.4474149734583, 978.6574698855486, 1003.678822776719, 10791.352518848895, 10882.455877206108, 10972.341659500455, 10976.737675167458, 11008.614698485515, 630683.0, 634847.0, 638370.0, 649017.0, 651811.0, 117296.0, 118216.0, 118266.40866795783, 118348.81651183378, 118586.0, 1009.9444530550891, 1015.0255754475786, 1028.943408112561, 1029.5367084811865, 1031.1132426113536, 18030.90984545069, 18149.18328675239, 18300.084995749894, 18352.541186470444, 18698.878067316004, 50310.2137248481, 50609.24086138637, 50717.23924141215, 52725.7363713179, 53520.0, 70623.0, 70688.23279418056, 71362.6431867858, 71581.841815818, 74119.6294018548, 7705.345045670956, 7743.45795794289, 7851.293383595504, 7861.685532578633, 8154.75535733929, 10378.481075946323, 11716.472758726048, 12296.81554776697, 12561.560345387868, 12628.558000469939, 10056.19550435978, 10337.0, 10639.734006649896, 10920.836187457353, 11139.498722557342, 10359.792804144026, 10664.51241995931, 10685.946570267099, 10986.395748233925, 11060.115190784878, 11250.043746281657, 11277.605283815356, 11358.375289359165, 11363.147763917905, 11389.0, 7666.578338191453, 7670.578118203553, 7743.070831500031, 7756.612169391621, 7805.609719514116, 8151.918480815116, 10320.43237621938, 10489.685309440729, 10867.456627168453, 10881.945590271998], "unit": "score", "name": "jquery.html", "value": 9228.368784976525}, {"lowerIsBetter": false, "replicates": [1302.2251760202676, 1592.243684249981, 1633.2976819967416, 1910.9140088696008, 2036.928707495237, 7937.9603101984485, 8733.519656418894, 8881.245094166987, 8884.02275749667, 8891.333150013743, 8562.44344117632, 8809.427387219826, 8812.295016398688, 8820.029796722356, 8829.86755198671, 2044.488877780555, 2096.2601041135895, 2434.342727463593, 2494.3390001649577, 2510.3724068982665, 2465.9753402466013, 2472.27068014936, 2473.2332976777166, 2473.9010439582394, 2474.8886300116446, 2430.173740928084, 2475.10896077412, 2498.837575557583, 2499.7250302466714, 2504.0860086068637, 2431.914882979096, 2442.7282627156737, 2451.570975079354, 2457.4225057111566, 2475.4306509502826, 2446.3150317911013, 2471.1845091119885, 2476.108600903673, 2476.6904136982876, 2497.250824752567, 8909.599068041955, 8970.86543701845, 8994.280457563445, 8998.05520420353, 8999.865002024975, 5373.59698022646, 5491.752871120809, 5497.835064948058, 5543.805966791143, 5546.112621980464, 3549.2369140634887, 3610.945835812465, 3689.538807649044, 3741.9522533690338, 3745.793981331026, 1045.3153184664056, 1056.7252514346249, 1067.5836423794726, 1078.4499905048403, 1079.87581428136, 11927.403629818475, 11932.761344773142, 11933.16467847251, 11961.700957476045, 11974.34141122238, 4550.772461376984, 4626.167289887785, 4719.1741445247635, 4762.690425122356, 4763.737994410271, 9513.571889265, 9545.188658964065, 9545.713628591153, 9553.904460955302, 9555.378900371454, 5383.353997520244, 5419.132938729785, 5422.0511410503, 5426.104692725735, 5428.864278392993, 4480.574345437179, 4640.561425957964, 4896.996115796253, 4947.950520494821, 5015.724135172528, 3815.21788033458, 3876.7092468064443, 3921.941170882439, 3948.881533553998, 3957.2085582883537, 1301.6290357248138, 1305.6996890715, 1308.9607311780662, 1314.822498962647, 1323.503686117706, 1357.2806412601337, 1363.5432130236284, 1378.131776980496, 1382.1154461144874, 1418.0, 8267.421280510307, 8311.376646751518, 8360.540170290571, 8370.748877533684, 8372.372072094617, 517.6581107925338, 525.8291055407008, 533.0458479322048, 537.8332716857786, 538.5045757902739, 6276.184096067574, 6283.403076707706, 6305.432511074026, 6346.238451385863, 6353.682315884187, 9830.0, 11042.447877606088, 11064.778704425866, 11067.114630829676, 11087.445627718744, 10547.947260263803, 10814.78370432587, 10817.972292632187, 10868.45657717111, 10965.0, 8362.623681934327, 8424.452410593292, 8470.576471176417, 8489.193526614961, 8561.315094792402, 7827.843443130992, 8056.758297251092, 8073.0, 8208.794780130545, 8218.260356567938, 9222.861657075015, 9363.157315841607, 9509.809803803746, 9538.093881081564, 9573.808523829624, 9618.086281803218, 9815.705528834147, 9960.900390995997, 9981.800363992825, 9993.600255989679, 6730.764423245163, 7276.381507571704, 7481.812954675959, 7485.1017877855, 7577.014988051518, 8243.05204901444, 8293.62678679473, 8307.376946728898, 8315.584220789058, 8330.0, 7171.426285897011, 7265.7093716252875, 7273.672684729306, 7409.740659076906, 7426.702931882664, 5783.652980821164, 7013.368796808311, 7031.191412987572, 7115.501914865909, 7303.452241081834, 7317.26827317264, 7453.478256521991, 7489.73785917512, 7516.661750221144, 7541.924580754342, 6745.2242992056545, 6775.186977562724, 6807.0810440589885, 6857.211420686485, 6859.485538584527, 6884.93115068863, 6899.48253880971, 6942.375186233263, 6963.7214511421, 6964.79105626832], "unit": "score", "name": "mootools.html", "value": 4844.629796283224}, {"lowerIsBetter": false, "replicates": [329.8350824587706, 329.9026787097806, 335.2858411583327, 337.68639990437197, 341.6719948849105, 6104.450599446049, 6443.516736244777, 6478.125453063835, 6481.4490768284695, 6515.2833188349305, 6466.094746735461, 6474.870502589945, 6493.870122597546, 6509.414152726254, 6526.6736663166885, 3675.926481470369, 4318.0, 4570.840020599279, 4645.27998160284, 4836.733979631119, 3983.541892682335, 4702.694324868872, 4747.643926705494, 4789.425268967729, 4802.351682522867, 4324.659355599759, 4329.870103896888, 4758.428988521382, 4771.9761401192945, 4784.976075119637, 4535.319702044703, 4561.1105834362315, 4676.994446194085, 4683.508231635663, 4769.5707386335225, 4080.6327430531096, 4082.4080508326424, 4092.9795351023054, 4097.180563887205, 4097.364908439196, 4903.7057776533165, 6114.938850611481, 6155.815325540241, 6162.490189903458, 6182.721777520022, 5537.36320323164, 5567.66594004361, 5567.916481252784, 5580.553555715533, 5580.748866301026, 6827.965860170667, 6833.111695479605, 6833.692483838189, 6836.042953986446, 6836.077129587492, 4291.613754762056, 4467.0, 4500.707454015511, 4522.773861306954, 4599.103174880899, 7195.856082878366, 7199.6040217788, 7253.637318134125, 7261.056062711867, 7272.0, 4552.772361381918, 4556.772161391984, 4562.977185114053, 4566.794494247767, 4568.200564901195, 4014.2573623879675, 4616.746078965622, 4623.976880115578, 4637.1421287062, 4646.7444290564345, 5469.671819690831, 5475.370332411744, 5479.808206712746, 5481.0, 5485.835424937259, 6577.6053436793945, 6881.10545629065, 6897.620630865351, 6902.723891044402, 6914.1702995639835, 1587.8729701623843, 1593.5697361712273, 1605.8233594304618, 1606.5100144455819, 1607.3490236454254, 950.9096635819586, 954.8519979403204, 1012.6405126180247, 1017.2472370445964, 1034.1623285139062, 6146.108814222002, 6340.334264902119, 6341.651209183539, 6381.266154392304, 6382.8723425531225, 7182.856342873113, 7189.820254493575, 7196.96401517989, 7235.059442272576, 7238.203797582261, 6408.487321014308, 6425.5502114851515, 6437.2918978912285, 6439.162908821823, 6450.612963222222, 3759.154190307159, 3771.6605505504635, 3774.169682669808, 3788.8484460621266, 3795.2978698940233, 6052.334243233241, 7209.279072092749, 7499.437542184358, 7532.472726909174, 7551.509151905108, 7315.4147668186415, 7345.0, 7361.1166660001145, 7368.0, 7368.410527157815, 7436.330730234305, 7483.850322993619, 7520.9623951880985, 7524.172341042481, 7533.20901305377, 7205.279472052753, 7205.901462371231, 7213.134423868959, 7230.783076507713, 7240.239774823568, 5682.573806964577, 6807.149106361705, 7007.369336759716, 7092.9645351772915, 7101.786946391617, 7427.665755040928, 7477.476576639583, 7490.951266822758, 7610.771676849703, 7783.104942931409, 4555.4988951216, 4607.7004994675235, 4616.907661846677, 4622.399088118523, 4624.329472226441, 7207.531510451804, 7209.495335326476, 7210.423166146591, 7227.457940654577, 7229.1325040993315, 6730.293319201609, 6950.679370919509, 6971.721131154697, 6988.860222795617, 6989.679902046487, 5572.0527510324155, 6929.3070692930305, 6933.479989000946, 6943.166819981635, 6948.965255173894, 6819.352161544645, 6820.35206655367, 6833.692483838338, 6837.008633748178, 6844.349786770249, 5606.467385598362, 6061.848453788691, 6612.94192929129, 6975.476839236976, 6978.337057979484, 6475.222973243241, 6490.123833282447, 6775.796726098225, 6790.422814060663, 6810.761623343357], "unit": "score", "name": "prototype.html", "value": 5013.095505945295}, {"lowerIsBetter": false, "replicates": [664.8570557330173, 675.9966200168999, 676.5399528320742, 704.7322017633298, 737.9003834482344, 15190.240487975598, 15395.384184632629, 15422.845771542281, 15426.69146617067, 15434.0, 13875.583732488016, 13949.860501394984, 14039.0, 14074.71850562988, 14079.0, 736.8047467421138, 749.4304328710192, 908.8364094463011, 908.9590968406437, 926.5089502563618, 915.3135148638521, 916.1525588830306, 924.9871390827034, 926.3006430145265, 928.9628414863431, 952.7808604021079, 959.7120863740885, 961.2550273537994, 961.423146112334, 962.37445660321, 773.5397438524097, 844.307667712476, 958.3387462650784, 974.1232890398697, 976.6386437018277, 607.271274470637, 726.96728647211, 727.3054233207274, 729.0485915879775, 730.5324592260957, 14087.436502539886, 14167.362468688934, 14171.503997360043, 14180.645483862883, 14202.50291239812, 12373.938130309381, 12396.504139834396, 12664.81002784959, 12740.554080607228, 12869.871301287054, 9996.800063998679, 10004.849927251096, 10074.345167564084, 10237.692869213935, 10856.470331176417, 3288.112209703391, 3466.959912026382, 3643.453481977698, 3651.1054791575966, 3723.646253605903, 80877.78683319755, 82114.17885821125, 82209.58895205485, 82308.0, 82617.0, 9523.999980002138, 9528.142467177988, 9532.571034303473, 9807.950960245296, 9921.652742154134, 22337.553248935255, 22354.0, 22401.43996400103, 22409.32772016842, 22427.88786056092, 7249.528780629243, 7479.887801682979, 7495.287947644965, 7521.247875212544, 7581.12817026038, 3455.94816077759, 3566.589842168132, 4107.691923105779, 4137.007118291588, 4215.346621273708, 3523.8061906595385, 3589.1565482111682, 3593.1735700788963, 3593.7664051836546, 3598.1544337080763, 638.2628064585411, 643.8905386084283, 646.2632598837329, 650.4763665249519, 651.2575663743337, 561.2507302750791, 562.5387182510302, 589.2163422647868, 613.8437128123796, 629.8425393651587, 7789.883151752728, 8113.594320283963, 8178.223068808454, 8330.541820199947, 8333.166683331618, 537.1968906484752, 551.6359202926129, 572.7880684146809, 626.8088233088861, 641.0832509511444, 3463.8915547024712, 3724.9627503724614, 3752.5309336332957, 3870.9419358709642, 4012.4382586437923, 80913.0, 85061.14938850656, 88020.0, 89768.0, 91495.0, 75799.0, 76016.0, 76856.15719214016, 78150.0, 78368.21631783723, 67015.32984670092, 67437.6628116866, 68760.0, 69972.65013674898, 70230.94653580303, 7584.2794934481135, 7625.3514818223475, 7764.5729484878875, 7777.688892444239, 7849.60751962411, 44227.11545769002, 44369.0, 44552.77723611361, 44810.327845081694, 45647.63057108292, 60462.39537604568, 62530.687346562976, 62732.37267627265, 63027.0, 63501.41246468875, 10019.92399918114, 10117.342372745748, 10161.237907157141, 10345.068943795095, 10407.791844163226, 10949.726256843642, 10976.670699879016, 11312.81450676408, 11575.363355015219, 11820.172587919107, 8371.279901514255, 10557.0, 11080.667579972614, 11110.277831940897, 11592.304461732323, 11047.502862371373, 11082.667519974091, 11137.053350465301, 11163.776724465628, 11504.079673626256, 10427.895721042996, 10562.366258024544, 10579.788404232026, 11138.888611113785, 11323.0, 9356.0, 9563.234941204826, 9685.806283874424, 9722.80554388894, 9797.363171393836, 9501.0, 9553.570089346134, 9618.663346782829, 9650.855237171307, 9654.758631034], "unit": "score", "name": "yui.html", "value": 6770.893204300084}], "name": "dromaeo_css", "value": 7381.6502490683915}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 111.0, 110.0, 118.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [155.0, 120.0, 145.0, 158.0, 116.0, 141.0, 139.0, 117.0, 162.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 137.3}, {"lowerIsBetter": true, "replicates": [188.0, 186.0, 184.0, 185.0, 185.0, 185.0, 185.0, 185.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 87.0, 80.0, 56.0, 60.0, 57.0, 77.0, 80.0, 64.0], "unit": "score", "name": "audio-fft", "value": 71.2}, {"lowerIsBetter": true, "replicates": [96.0, 92.0, 135.0, 80.0, 77.0, 85.0, 117.0, 79.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 96.0}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 86.0, 88.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 110.0, 128.0, 141.0, 149.0, 94.0, 95.0, 119.0, 102.0], "unit": "score", "name": "imaging-darkroom", "value": 112.5}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 85.0, 84.0, 86.0, 85.0, 85.0, 87.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 54.0, 55.0, 53.0, 54.0, 63.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [62.0, 67.0, 78.0, 72.0, 71.0, 69.0, 67.0, 67.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 82.0, 83.0, 83.0, 83.0, 82.0, 83.0, 85.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [130.0, 140.0, 135.0, 137.0, 132.0, 122.0, 125.0, 125.0, 141.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.7}, {"lowerIsBetter": true, "replicates": [141.0, 130.0, 141.0, 141.0, 138.0, 127.0, 139.0, 137.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 66.0, 67.0, 69.0, 66.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1427.0000000000002}]} 16:28:29 INFO - Return code: 0 16:28:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:28:29 ERROR - # TBPL SUCCESS # 16:28:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:28:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:28:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:28:29 INFO - 2016-03-29 16:28:29.729 screenresolution[1967:12934] starting screenresolution argv=screenresolution get 16:28:29 INFO - 2016-03-29 16:28:29.732 screenresolution[1967:12934] Display 0: 1600x1200x32@60 16:28:29 INFO - 2016-03-29 16:28:29.738 screenresolution[1968:12937] starting screenresolution argv=screenresolution list 16:28:29 INFO - Available Modes on Display 0 16:28:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:28:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:28:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:28:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:28:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:28:29 INFO - Intel Iris: 16:28:29 INFO - Chipset Model: Intel Iris 16:28:29 INFO - Type: GPU 16:28:29 INFO - Bus: Built-In 16:28:29 INFO - VRAM (Dynamic, Max): 1536 MB 16:28:29 INFO - Vendor: Intel (0x8086) 16:28:29 INFO - Device ID: 0x0a2e 16:28:29 INFO - Revision ID: 0x0009 16:28:29 INFO - Displays: 16:28:29 INFO - Display: 16:28:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:28:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:28:29 INFO - Display Serial Number: 1600x1200 60 16:28:29 INFO - Main Display: Yes 16:28:29 INFO - Mirror: Off 16:28:29 INFO - Online: Yes 16:28:29 INFO - Rotation: Supported 16:28:29 INFO - Return code: 0 16:28:29 INFO - Running post-action listener: _resource_record_post_action 16:28:29 INFO - Running post-run listener: _resource_record_post_run 16:28:31 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2621440; Write bytes: 703123456; Read time: 51; Write time: 2087 16:28:31 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381426176; Write bytes: 376301568; Read time: 28579; Write time: 674 16:28:31 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2621440; Write bytes: 297691136; Read time: 51; Write time: 1330 16:28:31 INFO - Running post-run listener: _upload_blobber_files 16:28:31 INFO - Blob upload gear active. 16:28:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:28:31 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:28:31 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:28:31 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:28:31 INFO - (blobuploader) - INFO - Open directory for files ... 16:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:32 INFO - (blobuploader) - INFO - Done attempting. 16:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:28:33 INFO - (blobuploader) - INFO - Done attempting. 16:28:33 INFO - (blobuploader) - INFO - Iteration through files over. 16:28:33 INFO - Return code: 0 16:28:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:28:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:28:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/429ba4b913b44a81926ca2af877575271c8849d6b19ed1211c7e76756a0077578cb1b67685120848d2a5077bb62539428d115081165f259e09f488930105733c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb6759928a7d0722a294f1dcc389d64efbc72412f6dc369654b97fbd27c7d451389df3cd212777ac9ff0e1cc823679f9e8497648a9ebc36df26129c8cc08bc8"} 16:28:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:28:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:28:33 INFO - Contents: 16:28:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/429ba4b913b44a81926ca2af877575271c8849d6b19ed1211c7e76756a0077578cb1b67685120848d2a5077bb62539428d115081165f259e09f488930105733c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb6759928a7d0722a294f1dcc389d64efbc72412f6dc369654b97fbd27c7d451389df3cd212777ac9ff0e1cc823679f9e8497648a9ebc36df26129c8cc08bc8"} 16:28:33 INFO - Running post-run listener: copy_logs_to_upload_dir 16:28:33 INFO - Copying logs to upload dir... 16:28:33 INFO - mkdir: /builds/slave/test/build/upload/logs 16:28:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.453903 ========= master_lag: 1.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-29 16:28:34.452256) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-29 16:28:34.457221) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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/429ba4b913b44a81926ca2af877575271c8849d6b19ed1211c7e76756a0077578cb1b67685120848d2a5077bb62539428d115081165f259e09f488930105733c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb6759928a7d0722a294f1dcc389d64efbc72412f6dc369654b97fbd27c7d451389df3cd212777ac9ff0e1cc823679f9e8497648a9ebc36df26129c8cc08bc8"} build_url:https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011010 build_url: 'https://queue.taskcluster.net/v1/task/DQOLymIsTrKJY6-PpPY_0g/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/429ba4b913b44a81926ca2af877575271c8849d6b19ed1211c7e76756a0077578cb1b67685120848d2a5077bb62539428d115081165f259e09f488930105733c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1eb6759928a7d0722a294f1dcc389d64efbc72412f6dc369654b97fbd27c7d451389df3cd212777ac9ff0e1cc823679f9e8497648a9ebc36df26129c8cc08bc8"}' ========= master_lag: 1.37 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-29 16:28:35.841295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-29 16:28:35.845623) ========= 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.48hGshEyll/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.EZvlCpG2vf/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005350 ========= master_lag: 4.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-29 16:28:40.746599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 16:28:40.746929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 16:28:41.008058) ========= ========= Total master_lag: 7.94 =========