builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0002 starttime: 1458687694.46 results: success (0) buildid: 20160322140509 builduid: 14b8372c39f04a33b93bb5207278ba1e revision: 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.465313) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.465816) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.466106) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005285 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.498358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.501733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.535438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.535855) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005742 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.591834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.592146) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.595646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.596040) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-22 16:01:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.4M=0.001s 2016-03-22 16:01:34 (13.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186661 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.802184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.805640) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.026358 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:34.866954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:01:34.867317) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 --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 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-22 16:01:34,948 truncating revision to first 12 chars 2016-03-22 16:01:34,948 Setting DEBUG logging. 2016-03-22 16:01:34,948 attempt 1/10 2016-03-22 16:01:34,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47ffc2a2f909?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 16:01:36,135 unpacking tar archive at: fx-team-47ffc2a2f909/testing/mozharness/ program finished with exit code 0 elapsedTime=1.422002 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-22 16:01:36.313159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:36.316540) ========= echo 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'47ffc2a2f909dd72bc061766d9f0f9b4badd6942'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 program finished with exit code 0 elapsedTime=0.005404 script_repo_revision: '47ffc2a2f909dd72bc061766d9f0f9b4badd6942' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:36.369674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:36.370095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 16:01:36.385569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-22 16:01:36.385939) ========= /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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:01:36 INFO - MultiFileLogger online at 20160322 16:01:36 in /builds/slave/test 16:01:36 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:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:36 INFO - {'append_to_log': False, 16:01:36 INFO - 'base_work_dir': '/builds/slave/test', 16:01:36 INFO - 'blob_upload_branch': 'Fx-Team', 16:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:36 INFO - 'branch': 'Fx-Team', 16:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:36 INFO - 'config_files': ('talos/mac_config.py',), 16:01:36 INFO - 'default_actions': ('clobber', 16:01:36 INFO - 'read-buildbot-config', 16:01:36 INFO - 'download-and-extract', 16:01:36 INFO - 'populate-webroot', 16:01:36 INFO - 'create-virtualenv', 16:01:36 INFO - 'install', 16:01:36 INFO - 'run-tests'), 16:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:36 INFO - 'download_minidump_stackwalk': True, 16:01:36 INFO - 'download_symbols': 'ondemand', 16:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:36 INFO - 'installer_path': 'installer.exe', 16:01:36 INFO - 'log_level': 'info', 16:01:36 INFO - 'log_name': 'talos', 16:01:36 INFO - 'log_to_console': True, 16:01:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:01:36 INFO - 'opt_config_files': (), 16:01:36 INFO - 'pip_index': False, 16:01:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:01:36 INFO - 'cmd': ('bash', 16:01:36 INFO - '-c', 16:01:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:01:36 INFO - 'enabled': True, 16:01:36 INFO - 'halt_on_failure': False, 16:01:36 INFO - 'name': 'check_screen_resolution'},), 16:01:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:01:36 INFO - 'cmd': ('bash', 16:01:36 INFO - '-c', 16:01:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:01:36 INFO - 'enabled': True, 16:01:36 INFO - 'halt_on_failure': False, 16:01:36 INFO - 'name': 'check_screen_resolution'},), 16:01:36 INFO - 'run_cmd_checks_enabled': True, 16:01:36 INFO - 'sps_profile': False, 16:01:36 INFO - 'sps_profile_interval': 0, 16:01:36 INFO - 'suite': 'dromaeojs', 16:01:36 INFO - 'system_bits': '32', 16:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:36 INFO - 'title': 't-yosemite-r7-0002', 16:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:36 INFO - 'use_talos_json': True, 16:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:36 INFO - 'work_dir': 'build'} 16:01:36 INFO - ##### 16:01:36 INFO - ##### Running clobber step. 16:01:36 INFO - ##### 16:01:36 INFO - Running pre-action listener: _resource_record_pre_action 16:01:36 INFO - Running main action method: clobber 16:01:36 INFO - rmtree: /builds/slave/test/build 16:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:38 INFO - Running post-action listener: _resource_record_post_action 16:01:38 INFO - ##### 16:01:38 INFO - ##### Running read-buildbot-config step. 16:01:38 INFO - ##### 16:01:38 INFO - Running pre-action listener: _resource_record_pre_action 16:01:38 INFO - Running main action method: read_buildbot_config 16:01:38 INFO - Using buildbot properties: 16:01:38 INFO - { 16:01:38 INFO - "project": "", 16:01:38 INFO - "product": "firefox", 16:01:38 INFO - "script_repo_revision": "production", 16:01:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:01:38 INFO - "repository": "", 16:01:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:01:38 INFO - "buildid": "20160322140509", 16:01:38 INFO - "pgo_build": "False", 16:01:38 INFO - "basedir": "/builds/slave/test", 16:01:38 INFO - "buildnumber": 610, 16:01:38 INFO - "slavename": "t-yosemite-r7-0002", 16:01:38 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:01:38 INFO - "platform": "yosemite_r7", 16:01:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:01:38 INFO - "branch": "fx-team", 16:01:38 INFO - "repo_path": "integration/fx-team", 16:01:38 INFO - "revision": "47ffc2a2f909dd72bc061766d9f0f9b4badd6942", 16:01:38 INFO - "stage_platform": "macosx64", 16:01:38 INFO - "builduid": "14b8372c39f04a33b93bb5207278ba1e", 16:01:38 INFO - "slavebuilddir": "test" 16:01:38 INFO - } 16:01:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:01:38 INFO - Running post-action listener: _resource_record_post_action 16:01:38 INFO - ##### 16:01:38 INFO - ##### Running download-and-extract step. 16:01:38 INFO - ##### 16:01:38 INFO - Running pre-action listener: _resource_record_pre_action 16:01:38 INFO - Running main action method: download_and_extract 16:01:38 INFO - mkdir: /builds/slave/test/build/tests 16:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:38 INFO - https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:38 INFO - Downloaded 1199 bytes. 16:01:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:01:38 INFO - Using the following test package requirements: 16:01:38 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:01:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:01:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:01:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'jsshell-mac.zip'], 16:01:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:01:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:01:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:01:38 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:01:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:01:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:01:38 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:01:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:38 INFO - https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:40 INFO - Downloaded 17860598 bytes. 16:01:40 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:01:40 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:01:43 INFO - Return code: 0 16:01:43 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:01:43 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:01:43 INFO - https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:45 INFO - Downloaded 17860598 bytes. 16:01:45 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:01:45 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:01:48 INFO - Return code: 0 16:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:48 INFO - https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:50 INFO - Downloaded 10848120 bytes. 16:01:50 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:01:50 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:01:50 INFO - Return code: 0 16:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:50 INFO - https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A1fYtukYTHKQcdLHMMcmHg/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:01:53 INFO - Downloaded 111273310 bytes. 16:01:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:01:53 INFO - mkdir: /builds/slave/test/properties 16:01:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:53 INFO - Contents: 16:01:53 INFO - build_url:https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:01:54 INFO - Running post-action listener: _resource_record_post_action 16:01:54 INFO - Running post-action listener: set_extra_try_arguments 16:01:54 INFO - ##### 16:01:54 INFO - ##### Running populate-webroot step. 16:01:54 INFO - ##### 16:01:54 INFO - Running pre-action listener: _resource_record_pre_action 16:01:54 INFO - Running main action method: populate_webroot 16:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:01:54 INFO - '--tppagecycles', 16:01:54 INFO - '7'], 16:01:54 INFO - 'tests': ['tsvgm']}}, 16:01:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:01:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:01:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:01:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'tests': ['damp', 'tps']}, 16:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['damp', 'tps']}, 16:01:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:54 INFO - 'other': {'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'other_l64': {'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'other_nol64': {'tests': ['a11yr', 16:01:54 INFO - 'ts_paint', 16:01:54 INFO - 'tpaint', 16:01:54 INFO - 'sessionrestore', 16:01:54 INFO - 'sessionrestore_no_auto_restore', 16:01:54 INFO - 'tabpaint']}, 16:01:54 INFO - 'svgr': {'tests': ['tsvgx', 16:01:54 INFO - 'tsvgr_opacity', 16:01:54 INFO - 'tart', 16:01:54 INFO - 'tscrollx', 16:01:54 INFO - 'cart']}, 16:01:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['tsvgx', 16:01:54 INFO - 'tsvgr_opacity', 16:01:54 INFO - 'tart', 16:01:54 INFO - 'tscrollx', 16:01:54 INFO - 'cart']}, 16:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'tests': ['tp5o']}, 16:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'talos_options': ['--e10s'], 16:01:54 INFO - 'tests': ['tp5o']}, 16:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'talos_options': ['--xperf_path', 16:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:54 INFO - 'tests': ['tp5n']}, 16:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:01:54 INFO - 'talos_options': ['--e10s', 16:01:54 INFO - '--xperf_path', 16:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:54 INFO - 'tests': ['tp5n']}}, 16:01:54 INFO - 'talos.zip': {'path': '', 16:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:01:54 INFO - Running post-action listener: _resource_record_post_action 16:01:54 INFO - ##### 16:01:54 INFO - ##### Running create-virtualenv step. 16:01:54 INFO - ##### 16:01:54 INFO - Running pre-action listener: _resource_record_pre_action 16:01:54 INFO - Running main action method: create_virtualenv 16:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:54 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:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:54 INFO - Using real prefix '/tools/python27' 16:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:58 INFO - Installing pip.................done. 16:01:58 INFO - Return code: 0 16:01:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01:58 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:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:58 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:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:58 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:01:58 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:01:58 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:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:58 INFO - 'HOME': '/Users/cltbld', 16:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:58 INFO - 'LOGNAME': 'cltbld', 16:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:58 INFO - 'MOZ_NO_REMOTE': '1', 16:01:58 INFO - 'NO_EM_RESTART': '1', 16:01:58 INFO - 'PAGER': '/bin/cat', 16:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:58 INFO - 'PWD': '/builds/slave/test', 16:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:58 INFO - 'SHELL': '/bin/bash', 16:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:01:58 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:58 INFO - 'USER': 'cltbld', 16:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:58 INFO - 'XPC_FLAGS': '0x0', 16:01:58 INFO - 'XPC_SERVICE_NAME': '0', 16:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:58 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:01:58 INFO - Cleaning up... 16:01:58 INFO - Return code: 0 16:01:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:01:58 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:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:58 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:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:01:58 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:01:58 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:01:58 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:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:58 INFO - 'HOME': '/Users/cltbld', 16:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:58 INFO - 'LOGNAME': 'cltbld', 16:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:58 INFO - 'MOZ_NO_REMOTE': '1', 16:01:58 INFO - 'NO_EM_RESTART': '1', 16:01:58 INFO - 'PAGER': '/bin/cat', 16:01:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:58 INFO - 'PWD': '/builds/slave/test', 16:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:58 INFO - 'SHELL': '/bin/bash', 16:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:01:58 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:58 INFO - 'USER': 'cltbld', 16:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:58 INFO - 'XPC_FLAGS': '0x0', 16:01:58 INFO - 'XPC_SERVICE_NAME': '0', 16:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:58 INFO - Downloading/unpacking psutil>=0.7.1 16:01:58 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:01:58 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:01:58 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:01:58 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:01:58 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:01:58 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:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:01 INFO - Installing collected packages: psutil 16:02:01 INFO - Running setup.py install for psutil 16:02:01 INFO - building 'psutil._psutil_osx' extension 16:02:01 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:02:02 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:02:02 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:02:02 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:02:02 INFO - building 'psutil._psutil_posix' extension 16:02:02 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:02:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:02:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:02:02 INFO - ^ 16:02:02 INFO - 1 warning generated. 16:02:02 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:02:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:03 INFO - Successfully installed psutil 16:02:03 INFO - Cleaning up... 16:02:03 INFO - Return code: 0 16:02:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:03 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:03 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:02:03 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:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:03 INFO - 'HOME': '/Users/cltbld', 16:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:03 INFO - 'LOGNAME': 'cltbld', 16:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:03 INFO - 'MOZ_NO_REMOTE': '1', 16:02:03 INFO - 'NO_EM_RESTART': '1', 16:02:03 INFO - 'PAGER': '/bin/cat', 16:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:03 INFO - 'PWD': '/builds/slave/test', 16:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:03 INFO - 'SHELL': '/bin/bash', 16:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:03 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:03 INFO - 'USER': 'cltbld', 16:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:03 INFO - 'XPC_FLAGS': '0x0', 16:02:03 INFO - 'XPC_SERVICE_NAME': '0', 16:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:05 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:02:05 INFO - Installing collected packages: mozsystemmonitor 16:02:05 INFO - Running setup.py install for mozsystemmonitor 16:02:06 INFO - Successfully installed mozsystemmonitor 16:02:06 INFO - Cleaning up... 16:02:06 INFO - Return code: 0 16:02:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:06 INFO - 'HOME': '/Users/cltbld', 16:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:06 INFO - 'LOGNAME': 'cltbld', 16:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:06 INFO - 'MOZ_NO_REMOTE': '1', 16:02:06 INFO - 'NO_EM_RESTART': '1', 16:02:06 INFO - 'PAGER': '/bin/cat', 16:02:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:06 INFO - 'PWD': '/builds/slave/test', 16:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:06 INFO - 'SHELL': '/bin/bash', 16:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:06 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:06 INFO - 'USER': 'cltbld', 16:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:06 INFO - 'XPC_FLAGS': '0x0', 16:02:06 INFO - 'XPC_SERVICE_NAME': '0', 16:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:09 INFO - Downloading docopt-0.6.1.tar.gz 16:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:10 INFO - Running setup.py install for blobuploader 16:02:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:10 INFO - Running setup.py install for requests 16:02:10 INFO - Running setup.py install for docopt 16:02:10 INFO - Successfully installed blobuploader requests docopt 16:02:10 INFO - Cleaning up... 16:02:10 INFO - Return code: 0 16:02:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:10 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:10 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:02:10 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:02:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:10 INFO - 'HOME': '/Users/cltbld', 16:02:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:10 INFO - 'LOGNAME': 'cltbld', 16:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:10 INFO - 'MOZ_NO_REMOTE': '1', 16:02:10 INFO - 'NO_EM_RESTART': '1', 16:02:10 INFO - 'PAGER': '/bin/cat', 16:02:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:10 INFO - 'PWD': '/builds/slave/test', 16:02:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:10 INFO - 'SHELL': '/bin/bash', 16:02:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:10 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:10 INFO - 'USER': 'cltbld', 16:02:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:10 INFO - 'XPC_FLAGS': '0x0', 16:02:10 INFO - 'XPC_SERVICE_NAME': '0', 16:02:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-BU6mk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-i9OZZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-gLo_Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-isPwbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-d3Xy9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-q5d0u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-an_JOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:11 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-k3ytEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-w4deQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XsrHZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-y9vaAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Taeqrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XIFwXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-6wnVQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-2DVBVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-kq2wlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:12 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CB22Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:12 INFO - Running setup.py install for manifestparser 16:02:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozcrash 16:02:13 INFO - Running setup.py install for mozdebug 16:02:13 INFO - Running setup.py install for mozdevice 16:02:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozfile 16:02:13 INFO - Running setup.py install for mozhttpd 16:02:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozinfo 16:02:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:13 INFO - Running setup.py install for mozInstall 16:02:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozleak 16:02:14 INFO - Running setup.py install for mozlog 16:02:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for moznetwork 16:02:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozprocess 16:02:14 INFO - Running setup.py install for mozprofile 16:02:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:14 INFO - Running setup.py install for mozrunner 16:02:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:15 INFO - Running setup.py install for mozscreenshot 16:02:15 INFO - Running setup.py install for moztest 16:02:15 INFO - Running setup.py install for mozversion 16:02:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:15 INFO - Cleaning up... 16:02:15 INFO - Return code: 0 16:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:15 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:15 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:02:15 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:02:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:15 INFO - 'HOME': '/Users/cltbld', 16:02:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:15 INFO - 'LOGNAME': 'cltbld', 16:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:15 INFO - 'MOZ_NO_REMOTE': '1', 16:02:15 INFO - 'NO_EM_RESTART': '1', 16:02:15 INFO - 'PAGER': '/bin/cat', 16:02:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:15 INFO - 'PWD': '/builds/slave/test', 16:02:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:15 INFO - 'SHELL': '/bin/bash', 16:02:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:15 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:15 INFO - 'USER': 'cltbld', 16:02:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:15 INFO - 'XPC_FLAGS': '0x0', 16:02:15 INFO - 'XPC_SERVICE_NAME': '0', 16:02:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:15 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-jyPQRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:15 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:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:15 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-sdYoJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-H3cBKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-xXY_lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fmiy48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-onMiSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-fEBoSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-h0mOnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-H0X6Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-YdcP1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-uR_k_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:16 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:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:16 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-00n3KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:17 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:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-lOOAG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:17 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:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ECDkYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:17 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:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-z4ZF_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:17 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:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-KxUSt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:17 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:02:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-624atB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02: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:02: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:02: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:02: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:02: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:02: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:02:20 INFO - Downloading blessings-1.6.tar.gz 16:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:20 INFO - Installing collected packages: blessings 16:02:20 INFO - Running setup.py install for blessings 16:02:20 INFO - Successfully installed blessings 16:02:20 INFO - Cleaning up... 16:02:20 INFO - Return code: 0 16:02:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:20 INFO - Reading from file tmpfile_stdout 16:02:20 INFO - Current package versions: 16:02:20 INFO - blessings == 1.6 16:02:20 INFO - blobuploader == 1.2.4 16:02:20 INFO - docopt == 0.6.1 16:02:20 INFO - manifestparser == 1.1 16:02:20 INFO - mozInstall == 1.12 16:02:20 INFO - mozcrash == 0.17 16:02:20 INFO - mozdebug == 0.1 16:02:20 INFO - mozdevice == 0.48 16:02:20 INFO - mozfile == 1.2 16:02:20 INFO - mozhttpd == 0.7 16:02:20 INFO - mozinfo == 0.9 16:02:20 INFO - mozleak == 0.1 16:02:20 INFO - mozlog == 3.1 16:02:20 INFO - moznetwork == 0.27 16:02:20 INFO - mozprocess == 0.22 16:02:20 INFO - mozprofile == 0.28 16:02:20 INFO - mozrunner == 6.11 16:02:20 INFO - mozscreenshot == 0.1 16:02:20 INFO - mozsystemmonitor == 0.0 16:02:20 INFO - moztest == 0.7 16:02:20 INFO - mozversion == 1.4 16:02:20 INFO - psutil == 3.1.1 16:02:20 INFO - requests == 1.2.3 16:02:20 INFO - wsgiref == 0.1.2 16:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:20 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:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:21 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:21 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:02:21 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:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:21 INFO - 'HOME': '/Users/cltbld', 16:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:21 INFO - 'LOGNAME': 'cltbld', 16:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:21 INFO - 'MOZ_NO_REMOTE': '1', 16:02:21 INFO - 'NO_EM_RESTART': '1', 16:02:21 INFO - 'PAGER': '/bin/cat', 16:02:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:21 INFO - 'PWD': '/builds/slave/test', 16:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:21 INFO - 'SHELL': '/bin/bash', 16:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:21 INFO - 'USER': 'cltbld', 16:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:21 INFO - 'XPC_FLAGS': '0x0', 16:02:21 INFO - 'XPC_SERVICE_NAME': '0', 16:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 INFO - Cleaning up... 16:02:21 INFO - Return code: 0 16:02:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:21 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:21 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:02:21 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:02:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:21 INFO - 'HOME': '/Users/cltbld', 16:02:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:21 INFO - 'LOGNAME': 'cltbld', 16:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:21 INFO - 'MOZ_NO_REMOTE': '1', 16:02:21 INFO - 'NO_EM_RESTART': '1', 16:02:21 INFO - 'PAGER': '/bin/cat', 16:02:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:21 INFO - 'PWD': '/builds/slave/test', 16:02:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:21 INFO - 'SHELL': '/bin/bash', 16:02:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:21 INFO - 'USER': 'cltbld', 16:02:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:21 INFO - 'XPC_FLAGS': '0x0', 16:02:21 INFO - 'XPC_SERVICE_NAME': '0', 16:02:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:21 INFO - Downloading/unpacking jsonschema 16:02: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:02: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:02: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:02: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:02: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:02: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:02:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:24 INFO - Downloading/unpacking functools32 (from jsonschema) 16:02:24 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:02:24 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:02:24 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:02:24 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:02:24 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:02:24 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:02:25 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:25 INFO - warning: no files found matching '*.txt' 16:02:25 INFO - no previously-included directories found matching 'build' 16:02:25 INFO - no previously-included directories found matching 'dist' 16:02:25 INFO - no previously-included directories found matching '.git*' 16:02:25 INFO - Installing collected packages: jsonschema, functools32 16:02:25 INFO - Running setup.py install for functools32 16:02:25 INFO - warning: no files found matching '*.txt' 16:02:25 INFO - no previously-included directories found matching 'build' 16:02:25 INFO - no previously-included directories found matching 'dist' 16:02:25 INFO - no previously-included directories found matching '.git*' 16:02:25 INFO - Successfully installed jsonschema functools32 16:02:25 INFO - Cleaning up... 16:02:25 INFO - Return code: 0 16:02:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:25 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 0x105ef6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f06420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff452dc5c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, '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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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:02:25 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:02:25 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:02:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:02:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:25 INFO - 'HOME': '/Users/cltbld', 16:02:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:25 INFO - 'LOGNAME': 'cltbld', 16:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:25 INFO - 'MOZ_NO_REMOTE': '1', 16:02:25 INFO - 'NO_EM_RESTART': '1', 16:02:25 INFO - 'PAGER': '/bin/cat', 16:02:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:25 INFO - 'PWD': '/builds/slave/test', 16:02:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:25 INFO - 'SHELL': '/bin/bash', 16:02:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:02:25 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:02:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:25 INFO - 'USER': 'cltbld', 16:02:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:25 INFO - 'XPC_FLAGS': '0x0', 16:02:25 INFO - 'XPC_SERVICE_NAME': '0', 16:02:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:25 INFO - Downloading/unpacking flake8 16:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:25 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:02:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:02:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:02:28 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:02:28 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:02:28 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:02:28 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:02:28 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:02:28 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:02:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:02:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:02:28 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:02:28 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:02:28 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:02:28 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:02:28 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:02:28 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:02:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:02:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:29 INFO - no previously-included directories found matching 'docs/_build' 16:02:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:02:30 INFO - Running setup.py install for pep8 16:02:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:30 INFO - no previously-included directories found matching 'docs/_build' 16:02:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:02:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:02:30 INFO - Cleaning up... 16:02:30 INFO - Return code: 0 16:02:30 INFO - Running post-action listener: _resource_record_post_action 16:02:30 INFO - Running post-action listener: _start_resource_monitoring 16:02:30 INFO - Starting resource monitoring. 16:02:30 INFO - ##### 16:02:30 INFO - ##### Running install step. 16:02:30 INFO - ##### 16:02:30 INFO - Running pre-action listener: _resource_record_pre_action 16:02:30 INFO - Running main action method: install 16:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:30 INFO - Reading from file tmpfile_stdout 16:02:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:30 INFO - Reading from file tmpfile_stdout 16:02:30 INFO - Output received: 16:02:30 INFO - Usage: mozinstall [options] installer 16:02:30 INFO - Options: 16:02:30 INFO - -h, --help show this help message and exit 16:02:30 INFO - -d DEST, --destination=DEST 16:02:30 INFO - Directory to install application into. [default: 16:02:30 INFO - "/builds/slave/test"] 16:02:30 INFO - --app=APP Application being installed. [default: firefox] 16:02:30 INFO - mkdir: /builds/slave/test/build/application 16:02:30 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:02:30 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:03:04 INFO - Reading from file tmpfile_stdout 16:03:04 INFO - Output received: 16:03:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:03:04 INFO - Running post-action listener: _resource_record_post_action 16:03:04 INFO - ##### 16:03:04 INFO - ##### Running run-tests step. 16:03:04 INFO - ##### 16:03:04 INFO - Running pre-action listener: _resource_record_pre_action 16:03:04 INFO - Running main action method: run_tests 16:03:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:04 INFO - 2016-03-22 16:03:04.663 screenresolution[1642:7447] starting screenresolution argv=screenresolution get 16:03:04 INFO - 2016-03-22 16:03:04.665 screenresolution[1642:7447] Display 0: 1600x1200x32@60 16:03:04 INFO - 2016-03-22 16:03:04.671 screenresolution[1643:7449] starting screenresolution argv=screenresolution list 16:03:04 INFO - Available Modes on Display 0 16:03:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:04 INFO - Intel Iris: 16:03:04 INFO - Chipset Model: Intel Iris 16:03:04 INFO - Type: GPU 16:03:04 INFO - Bus: Built-In 16:03:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:04 INFO - Vendor: Intel (0x8086) 16:03:04 INFO - Device ID: 0x0a2e 16:03:04 INFO - Revision ID: 0x0009 16:03:04 INFO - Displays: 16:03:04 INFO - Display: 16:03:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:04 INFO - Display Serial Number: 1600x1200 60 16:03:04 INFO - Main Display: Yes 16:03:04 INFO - Mirror: Off 16:03:04 INFO - Online: Yes 16:03:04 INFO - Rotation: Supported 16:03:04 INFO - Return code: 0 16:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:03:04 INFO - Python 2.7.3 16:03:04 INFO - Return code: 0 16:03:04 INFO - grabbing minidump binary from tooltool 16:03: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:03:04 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 0x105d95e00>, '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 0x105bbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d90b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:03:04 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:03:04 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:03:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:04 INFO - Return code: 0 16:03:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:03:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:03:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:03:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:03:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:03:06 INFO - Return code: 0 16:03:06 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/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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:03:06 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/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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:03:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAo9QnvX5G/Render', 16:03:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:06 INFO - 'HOME': '/Users/cltbld', 16:03:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:06 INFO - 'LOGNAME': 'cltbld', 16:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:06 INFO - 'MOZ_NO_REMOTE': '1', 16:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:06 INFO - 'NO_EM_RESTART': '1', 16:03:06 INFO - 'PAGER': '/bin/cat', 16:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:06 INFO - 'PWD': '/builds/slave/test', 16:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:06 INFO - 'SHELL': '/bin/bash', 16:03:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iqizk0bVxy/Listeners', 16:03:06 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 16:03:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:06 INFO - 'USER': 'cltbld', 16:03:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:06 INFO - 'XPC_FLAGS': '0x0', 16:03:06 INFO - 'XPC_SERVICE_NAME': '0', 16:03:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:06 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/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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:03:06 INFO - mozversion application_buildid: 20160322140509 16:03:06 INFO - mozversion application_changeset: 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 16:03:06 INFO - mozversion application_display_name: Nightly 16:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:06 INFO - mozversion application_name: Firefox 16:03:06 INFO - mozversion application_remotingname: firefox 16:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:03:06 INFO - mozversion application_vendor: Mozilla 16:03:06 INFO - mozversion application_version: 48.0a1 16:03:06 INFO - mozversion platform_buildid: 20160322140509 16:03:06 INFO - mozversion platform_changeset: 47ffc2a2f909dd72bc061766d9f0f9b4badd6942 16:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:03:06 INFO - mozversion platform_version: 48.0a1 16:03:06 INFO - using testdate: 1458687786 16:03:06 INFO - actual date: 1458687786 16:03:06 INFO - starting webserver on 'localhost:49270' 16:03:06 INFO - SUITE-START | Running 2 tests 16:03:06 INFO - TEST-START | dromaeo_css 16:03:06 INFO - operating with platform_type : mac_ 16:03:06 INFO - Initialising browser for dromaeo_css test... 16:03:06 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpY6tQhz/profile http://localhost:49270/getInfo.html) 16:03:08 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:03:08 INFO - PROCESS | 1661 | colorDepth:24 16:03:08 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:03:08 INFO - PROCESS | 1661 | __metrics 16:03:09 INFO - PROCESS | 1661 | 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:03:09 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:03:09 INFO - TEST-INFO | 1661: exit 0 16:03:09 INFO - Browser initialized. 16:03:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:03:09 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpY6tQhz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:21 INFO - PROCESS | 1664 | RSS: Main: 247349248 16:03:21 INFO - PROCESS | 1664 | 16:04:12 INFO - PROCESS | 1664 | 1458687852616 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:06:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:06:25 INFO - PROCESS | 1664 | RSS: Main: 377483264 16:06:25 INFO - PROCESS | 1664 | 16:09:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:09:28 INFO - PROCESS | 1664 | RSS: Main: 384278528 16:09:28 INFO - PROCESS | 1664 | 16:12:30 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:12:30 INFO - PROCESS | 1664 | RSS: Main: 377163776 16:12:30 INFO - PROCESS | 1664 | 16:15:32 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:15:33 INFO - PROCESS | 1664 | RSS: Main: 337063936 16:15:33 INFO - PROCESS | 1664 | 16:18:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:18:37 INFO - PROCESS | 1664 | RSS: Main: 336986112 16:18:37 INFO - PROCESS | 1664 | 16:21:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:21:40 INFO - PROCESS | 1664 | RSS: Main: 389693440 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | __start_tp_report 16:21:40 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 16:21:40 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 16:21:40 INFO - PROCESS | 1664 | |i|pagename|runs| 16:21:40 INFO - PROCESS | 1664 | |0;dojo.html;3444.328355970586;3492.493588429678;3518.278752855665;3528.9647103528955;3571.357155711971;5561.833145005657;5603.467670571295;5608.831735047945;5622.7188640567965;5677.659340439576;4600.493945665974;5656.095024796034;5667.688277144755;5783.306003279612;5797.072468405056;5047.293378926953;5070.391553013635;5089.923651145235;5098.796048158069;5232.241325007891;5204.9739751301195;5249.8950020999555;5266.710330931797;5318.1225097858805;5327.520523152915;5041.017001684673;5132.101882170643;5140.228965655144;5158.432572417031;5208.348956380452;5120.308758317617;5123.718195499246;5136.768845401966;5139.7687104080405;5142.04872098663;5088.974555127238;5130.71781052042;5148.61385396093;5151.587872970191;5178.508041736029;5482.780688772445;5486.698231597261;5502.8349149525575;5514.889702205974;5537.363203231599;5981.312149102865;6075.848103797396;6083.209182806251;6107.328193898667;6112.174856394418;6069.9947200111965;6086.249307700361;6102.847428814271;6133.264008318985;6140.105498721233;5669.43305669438;5716.685582292972;5755.884882302331;5783.855403614902;5805.651660900359;5552.86117847049;6333.873322533524;6343.714532846033;6357.364263573698;6371.840703982345;5878.588498805128;5958.851028724316;6037.456628903332;6045.576809623372;6051.667158306247;6110.042400473247;6191;6217.564770466024;6219.844503887439;6222.408871157233;6147.72335244915;6151.384861513813;6159.353267906805;6180.072989051679;6184.752609895644;5958.314793798682;6032.969835150796;6099.298580663191;6130.662813545208;6197.411245931629;4810.278458231223;4840.661153719206;4881.8535443936735;4886.780094895738;4903.926441103386;4329.76186309756;4339.218940590724;4341.82632694695;4345.847895323712;4374.562543745664;5465.316835395575;5542.307211598551;5573.359063707644;5587.525060369914;5640.746166422521;6102.792231004478;6137.8060289513105;6224.284207316216;6242.313345531988;6250.874982500324;5506.063969125178;5568.192612071308;5581.134924086773;5584.692841893735;5614.9157762633595;5204.635675502678;5309.7079660618265;5315.6279060465395;5337.226102215157;5343.385510666323;6277.466415354746;6280.309165991737;6349.428551430394;6365.904511432424;6372.394622510854;5159.2003239497935;6181;6189.412005859436;6189.752409903734;6193.597416167935;6340.365963403623;6356.364363563606;6380.1067850501895;6392.073149393219;6396.104545363746;5947.256592925884;6038.69806509664;6042.184305118929;6078.209832721718;6123.540734445023;6162.044883043135;6163.598755970808;6206.224221972254;6219.036049412348;6223.315435302023;5936.28764548257;6011.338752737282;6018.699065046818;6020.969895150496;6057.273127224761;5717.685527296038;5862.970685146547;5952.285725712769;6028.57799953999;6100.786472473442;5233.267342571967;5864.794732184353;5871.706414679164;5878.118282257525;5884.58807883444;6003.369646187088;6006.309274433496;6015.488683461955;6016.8796624068145;6017.578769486094;5736.971315143398;5815.41845815415;5817.127430885401;5821.417858214145;5911.290645122613 16:21:40 INFO - PROCESS | 1664 | |1;ext.html;491.9619602638434;523.8418846981538;577.8270111673302;633.170546583975;635.0379175549044;30853.69146308539;31399.843000785022;31408.214794630116;31454.213644658867;31495.370092598136;32047;40905.97735056625;41230.38154427686;41257;41298.38052429216;8628.913710862873;9567.282453815975;9606;9721.805563888718;9772.902270977305;9595.472249026301;9730.610775569005;9735.026497350244;9756.41461512308;9773.07155820196;9706.174975127122;9795.461249631267;9807.117359437649;9809.21526277896;9810.70567882961;9681.419114853132;9909.90090099097;9931.106200441995;9933.10602045812;9935.850962235609;8289.295409890166;9824.852627210597;9825.803483930353;9829.852552211723;9846.359986600919;34442.82778586091;42686.14627707459;42725.145497089885;42774.93062673427;42780.57219427797;3283.9835800820842;3286.4413049781597;3417.3165366926464;3425.8972230833115;3490.685838274542;29649.70350296491;29819.552706709415;30218.395632087235;30642.080737577908;30772.692273077206;2783.1789622061337;2813.198238502017;2829.9858500707364;2857.0286102724967;2869.196624945019;470849.2915070874;471167;472029.63985180197;472295;472462;59548.70225648844;68734;69294.65352673305;74835.62582187055;75636;65831.67084164644;72049;72105.2789472109;72111;72141;16884.662306753795;17308.394206202975;17320.220590073477;17322.22050007753;17370.697197710222;13016.739665206644;13118.016148788878;13120.737585248433;13124.60626181197;13155.947524198042;17554.66461372335;21182.046807893683;21519.46201344979;21643.891780541;21691.566168676854;7256.0567126273245;7398.482106252618;8732.388732788644;8764.386492945432;8830.293576513863;1008.3496144986443;1022.7085280694967;1065.3927261460892;1110.6949334531894;1166.4284500594647;26444.206673799818;29691.703082968892;29730.702692972794;30309.69690303113;30490.695093048784;877.7893305606608;1113.6770336602294;1153.5616465742964;1191.5948577483698;1195.0857593940643;11529.769404611861;15116.848831511545;15182.924085379724;15386;15465.304061317267;501777;513659;514653;515597;520018;60153;60383.69808151019;60395.39604603898;60459;60585.69707151436;1277.572013375511;1358.3276278242333;1476.5865557643876;1492.060002198608;1515.7347464193722;24563.508729824945;28713;29325.56011659784;29791.25521861884;30157.69842301549;49341.75329123331;49892.50107498879;50167;50387;50468.22424766526;364212;366542;366768;367229.16385417903;367875;29403;32748.85379011723;33424;34279.65720342765;34380.656193437746;42168;42428.151436971704;42871.7856410716;43144.56855431406;43721.12557748891;34989.77535786235;35198.296034079685;35526.64473355337;36225;36288.63711362958;34342.969710908714;34467.482987755706;35112.64887351094;35202.29595408026;35301.47047794234;36065.639343607276;36067.639323606425;36406.635933640326;37019.8149009264;37046.814765926;31432.68567314389;32150.678493215702;32317.51523727193;32717;33241.50137747984;21446.356609301747;23551.646725298793;23973.400664983514;24073.51852962896;24332.87833560821 16:21:40 INFO - PROCESS | 1664 | |2;jquery.html;331.1373871065873;358.3102527634304;361.04503588009715;362.7569528415961;368.4399712437094;19175.13711882965;19503.927283999376;20712.378628641163;21071.683924741104;21161.68257476135;19874.006299685032;20134.496637584067;20352.982350882434;21089.47276318093;21180.470488237803;5741.19623252746;5883.88232235355;5963.61236519627;5980.401959804029;5996.160537524728;4215.768132752697;4274.722143060707;5226.503482169188;5935.673537955411;6524.804255872307;6427.485801135898;6468.4825213983;6469.4177524022825;6474.546781725281;6482.448991835699;5640.717964101799;5887.7939272125695;5915.792947246847;5924;6400.967995160017;3816.8091595420397;4860.878478038042;5470.316210473691;5638.407967163471;5717.828465146011;13247.337633118306;13462.798058029137;13481.662958426019;15174.24128793556;24527.632085518733;2041.2007296375582;2135.29535253366;2144.1530595414724;2229.4314949687887;2607.7261887501727;9596.472194029326;9696.903030969741;9709.977897851215;9935.801283974351;10323.63867264642;1722.8793984421095;1773.8935663860082;1797.7213531902576;1809.9276028958825;1855.1466325490292;94122.0587794127;96137.51931240299;101328;101445.4927725364;101829;8884.73345799627;10967.616133435291;11172.385518796544;11354.148438866952;11382.260153090188;11994.520219191309;13099.607011789662;13687.863121368859;13692.931535342259;13733.45066197361;8406.117357677478;8546.05993340732;8577.485350878967;8623.913760862311;8628.52543110135;8688.695895643623;8715.041345451995;8732.388732788771;8791.780205494786;8801.911980880237;4445.755483448376;4521.073179998092;4521.367008618796;4591.563801438858;4619.076184763061;1839.705647096458;1886.7075603281514;1897.1557656842572;1913.6651086059883;1935.6225536020622;757.8105473631592;923.8106188231396;949.8052899155656;990.2919412620012;1009.5507499162802;19640.901795491216;19885.502862428555;20141.39575812728;20235.089420975797;20277.59444811125;957.4733896357116;957.760559860035;980.2060331131663;986.2652324018652;992.156666833186;10723.624673136559;10973.231873768918;10987.121030317556;10990;11012;572818;608823;610455;610893.8910610926;625973;66273;103355;106282.75381089997;106292.46853765682;107589.46205268924;933.2533972821716;1040.5369610523396;1043.8068957242933;1073.355986408149;1094.5621751299384;17833.286668533114;17833.643327133126;18159.914019345542;18433.53916152107;18460.723089153944;46491.76754116208;47390.52609473861;48150.16457965988;48298.75850620725;50303.49696502988;64174.67912660407;65236.69526609346;65954.34045659674;66197;68047.65976170088;7672;7740.883886741816;7822.882656760039;7830.1386847447875;7864.252895974873;9102.544872756203;11685.474153662935;12161.939190303992;12333.260004399765;12458.00335973102;9908.256880734118;10464.110550603284;10826.40454774995;10911.236213464981;11001.724956876142;10277.84583231267;10373.273870828969;10533.789324213627;10695.358278503003;10755.408452535186;5964.045752679551;8455.619497122521;10665.626703065356;10829.512671929624;11029.897010298906;7407.481476296607;7626.436580500873;7654.693812247448;7690.577018264049;8137.552434615916;8157.796055098433;10046.899531004596;10584.994425529563;10752;10897.455127243764 16:21:40 INFO - PROCESS | 1664 | |3;mootools.html;1465.9193744344057;1605.7591361295804;1635.386729976259;1934.4003358958714;2049.682299243617;8046.235607617275;8620.181082797131;8754;8770.079141690127;8790.077041910596;8611.91388086119;8839.425437346568;8839.867401988975;8844.204021638052;8854.33592480565;2204.9559008819815;2439.9390015249583;2485.850848949064;2500.5374005808894;2524.356289146265;2510.6108553174195;2510.7991360691194;2518.899244030237;2525.5959046552557;2527.4692314613953;2430.80553555716;2456.987715061431;2471.5798314286526;2474;2477.8973356856204;2412.7225369082516;2466.8889899954547;2477.306354220821;2482;2484.254723582918;2438.2197696737053;2442.8778561072054;2462.8522288662557;2476.9752302476923;2483.8385504942303;8812.16284452976;8866.202041816203;8898.332625053146;8903.866442003375;8924.419912705718;5381.0583147948955;5544.417836127229;5586.41342659019;5587.1339942309005;5592.328920529562;2944.1461976026926;3587.515685382466;3611.205534782344;3649.5073165122635;3657.4696668982847;1033.137330329176;1047.4134484688598;1048.308116643012;1052.5686262783304;1059.8728152621734;12078;12080.456379462945;12088.697782555506;12102.152849300552;12114.152009359348;4855.732934688626;4884.462709101996;5014.997000599895;5026.597872170218;5035.697858128524;10278.794424111476;10304.484775761182;10360.326578772356;10384.948075259575;10406.479676016168;5515.117581186991;5567.805126820623;5574.526165275915;5584.385717571064;5586.944130558723;4505.797239124247;4609.7695115244105;4701.6003639690325;4855.587275081658;4861.29511220871;3929.6856251500385;4013.7591744495426;4037.253108174997;4059.6955228357992;4088.632023117934;1310.5740634293702;1312.7571399291162;1318.0773458578842;1324.0863803975226;1328.6611913961879;1390.9095908765898;1404.894632902516;1407.7536431124513;1433.6989232261342;1436.827580690303;8283;8395.874061889077;8412.873806892901;8425.988881334279;8439.367047471464;505.29511331692083;514.565192412411;514.7323391836225;515.5257163409672;516.8501134670903;6308.337624549448;6359.650219237894;6361.077643741724;6367.42693157618;6373.458256048195;10234.6417875374;10847.186461015455;10862.239643225057;10997.725056873482;11005.834912476319;10434.791304174027;10684.679459616069;10733.946330268298;10765.407902565434;10861.02250797432;8402.117777633383;8410.87383689233;8467.915320846836;8551.315894728406;8571.742847714579;7851.175626559358;8034.276915077671;8045.07481639619;8054.677812887418;8152.184781521801;7480.177180510031;9073.863892041756;9329.953350233205;9402.106799854002;9484;9469.053094690476;9678.225741940487;9751.902480975099;9833.754156146153;9998.850017249893;6867.828304292432;7080.858382832212;7265.382442492447;7527.247275272429;7667.846643066996;8354.331653467829;8403;8408.495490270603;8432.873506897278;8437.325013998989;6491.967540162269;7426.443016773872;7442.553446793209;7540.019797426299;7605.277498637621;7253.673584688807;7300.707971681073;7353.558786472829;7427.554346739213;7483.214262502359;7728.45900786962;7814.6874125034365;7817.843643126992;7829.1779363168325;7861.646225919962;6687.565308254948;7004.859902802017;7057.788266352018;7083.610401427971;7084.185318688416;6896.793096207121;6976.337247961435;6980.336867997532;6986.895196572157;7038.507304488637 16:21:40 INFO - PROCESS | 1664 | |4;prototype.html;326.20243504631173;330.24044697196456;334.44649105730025;336.2853935387302;339.80970656432385;5302.390225124112;5363.570914326854;6549.214094308678;6641.435477984371;6645.0364697118885;6015.157877897098;6623.90064149037;6644.568103073297;6650.7339706411685;6665.133532640762;4684.110019096361;4811.158047341719;4822.937434728955;4856.708597484145;4935.3337299464565;4790.736509491977;4857.878553036185;4868.634852386068;4877.8780530486665;4879.438864530571;4814.614830813544;4819.710817350952;4840.104580652573;4840.322354870321;4841.3222148899185;3902.551206611219;3976.4631774710624;4768.213244814601;4809.158397280462;4809.182438985381;3989.341758609826;4063.451434056394;4149.564295748933;4158.272302347107;4161.52142503613;5237.214417837316;6211.875762484725;6290.24517057956;6334.398232167937;6342.619442833445;5710;5710.971445142748;5722.54219662426;5813.389594092644;5825.796097136622;6060.000099983497;7063.682134303917;7085.574865508086;7090.361867431956;7106.111736032996;4506.3916371290115;4671.743054132022;4677.88305292367;4685.484596694361;4685.688007357945;7163.355298023151;7422.517536360173;7441.2930771576075;7444.36722878556;7455.4781165318445;4497.707649002804;4614.446266448048;4628.097520983443;4628.120657075145;4642.930356044662;4705.95294047062;4712.622990160848;4713.222318317507;4715.693479923794;4720.0559888022535;5597.972010139923;5605.243292155588;5608.327000759935;5609.887802243932;5614.6631202128;6882.724691012303;7157.4274058075225;7163.8479069210425;7178.24628414009;7178.712851485987;1607.7588361745597;1608.4450864451746;1626.4957863062489;1629.1121338870344;1629.39712306445;1023.4217667018111;1025.466757286222;1031.6698656429871;1043.4000449741277;1046.4610725476387;6284.12022316876;6476.805695829133;6482.967585162044;6547.803565893031;6624.470042396597;5919.437653422918;7239.782806515813;7327.45044121693;7412.258774122544;7422.443316751265;6525;6550.737970481223;6680.164979377578;6681.432078273304;6683.732650694015;3860.3823388258306;3900.941485877714;3910.8240129194255;3912.4131380292615;3917.490726205575;7425.294597013275;7696.11494678108;7731.497452665559;7734.342580880576;7740.071191456948;7610.771676849703;7656.349210317074;7662.310392064629;7669.693212271558;7675.078990521061;7696.307332339892;7706.460547761715;7710.614469276514;7720.806979825549;7721.575313357819;6649.867002659823;7341.375983041501;7360.705571777069;7367.447441441806;7368.784150615088;5987.251593550806;6866.622335771381;7281.871309946967;7286.781396558112;7296.087989001375;7661.655225514976;7698.730544430918;7705.460617756703;7705.691772329044;7717.996660434333;4599.770011499345;4604.700694454849;4609.1703493371515;4609.193391156601;4612.30815377696;7335.77992660221;7341.375983041287;7343.4492413068165;7343.8898416522725;7344.926550734638;6837.863242735217;7108.964455177898;7114.466415018791;7135.108111486064;7149.678264478215;7070.4343652508705;7112.679929403293;7115.75094871677;7129.7861064168155;7134.393576546052;6948.478864085113;6980.197277312971;6982.615956122462;6989.126359205099;7018.964905175441;6857.245702972768;7120.643967801693;7136.643167841691;7141.750038748619;7147;6659.733610655519;6925.896111558432;6940.167179938439;6967.268436814062;6973.58158510491 16:21:40 INFO - PROCESS | 1664 | |5;yui.html;692.698676075907;748.7454265549712;749.7638243953154;758.480440897985;772.7797577690358;15135.697286054286;15352.155631440295;15353.30910109045;15378.92310538447;15382.384704611815;13797.793033104512;14182.361793719281;14210.857891421083;14215.147091174536;14224.288785560731;743.2567432567419;754.4002517998177;764.3884892086337;937.1518775508176;939.5161491831713;926.1248120526105;950.752804270891;950.8240975419535;951.9476428796413;952.0859974424561;982.5234761140841;984.5274268351196;986.7730422002944;987.1461186074066;991.6727479931641;783.9921600783977;824.4476200945381;977.5698692575244;977.5698692575244;989.7822479054596;725.9491835571512;726.3680597879826;726.8182954261434;729.7445893937132;732.8021434212786;14999.475018374415;15055.171965541891;15058.54824355271;15081.698366032728;15083.019603725723;12509.06182036351;12554.246745195318;12630.557930472389;12804.103712740112;12911.096223264376;9931.789892954941;10180.185585153169;10871;10908.454577271104;11251.887481125166;3523.7181025518153;3722.925541489155;3727;4420.292753159511;4443.666724995606;72523;73467;74240;74350;74519.62740186264;9269.814603708022;9355.017723139108;9534.332596718163;9542.188913942255;10019.148372388283;22018.339449816212;22020.449488762908;22031.889840551015;22069.448263793212;22079;6519.674016299166;6728.091707619409;6837.863242735118;6854.691538880762;6891.655417229119;3851.5185601799776;3908.413737939275;3912.471816304819;3912.8043597819997;3920.6079392060565;3689;3737.047053001522;3741.7006639468777;3741.812909354576;3743.232637309345;649.5842660697158;659.9769008084791;663.7046514301089;669.0432681265739;691.1705952856491;537.2103008577385;579.9449052340021;589.460643511191;595.5295316699759;616.0851136062943;7907.169747176578;8016.198380161937;8071.757847264592;8072.798180045428;8110.716124935717;460.41297345884266;472.99763501182275;575.2923903598513;598.5092224376057;600.5645906717594;3780.4896338993885;3799.1831756172555;3808.7333886628226;3913.178232571192;3973.920521589552;93037.53481232551;94567;95769.52115239379;95947.52026239964;97644;67116;72192;79642.6017869907;79822.60088699519;80029;70573.64713176401;70769.93845092328;70780;71183.28816711767;72418;7114.395276401564;7426.702931882664;7453.217412171861;7602.961985190039;7697.923020769721;49481.752591236815;50838.49161508486;51122.74438627783;51144;52021.21968170556;55402;65564.34435655773;65827.01259481016;70439;71995.28004719886;7990.440669153103;10229.181665466596;10269.640562580573;10377.429241391796;10807.567697292021;10120.139788118093;10230.13556204264;10240.385576865114;10241.283110182216;10712.410817405118;10192.898071019492;10264.332818366782;10562.683119506428;10569.947150264199;10590;8459.873101903599;8813.175573352806;10153;10315.948420257851;10678.572857085941;9956.800863982535;10325.793484130425;10374;10476.738081548023;10740.946295268473;8824.735257942271;8836.116388361112;8852.778680533038;8863.064264180799;9094.045125261753;8201.42590018693;8871.467711937305;8943.060978597154;8957.372983891066;9094.226990705863 16:21:40 INFO - PROCESS | 1664 | __end_tp_report 16:21:40 INFO - PROCESS | 1664 | __start_cc_report 16:21:40 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1210 16:21:40 INFO - PROCESS | 1664 | __end_cc_report 16:21:40 INFO - PROCESS | 1664 | __startTimestamp1458688900110__endTimestamp 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | ------- Summary: start ------- 16:21:40 INFO - PROCESS | 1664 | Number of tests: 6 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5659.28 Median:5821.42 stddev:621.95 (10.7%) stddev-sans-first:599.09 16:21:40 INFO - PROCESS | 1664 | Values: 3444.3 3492.5 3518.3 3529.0 3571.4 5561.8 5603.5 5608.8 5622.7 5677.7 4600.5 5656.1 5667.7 5783.3 5797.1 5047.3 5070.4 5089.9 5098.8 5232.2 5205.0 5249.9 5266.7 5318.1 5327.5 5041.0 5132.1 5140.2 5158.4 5208.3 5120.3 5123.7 5136.8 5139.8 5142.0 5089.0 5130.7 5148.6 5151.6 5178.5 5482.8 5486.7 5502.8 5514.9 5537.4 5981.3 6075.8 6083.2 6107.3 6112.2 6070.0 6086.2 6102.8 6133.3 6140.1 5669.4 5716.7 5755.9 5783.9 5805.7 5552.9 6333.9 6343.7 6357.4 6371.8 5878.6 5958.9 6037.5 6045.6 6051.7 6110.0 6191.0 6217.6 6219.8 6222.4 6147.7 6151.4 6159.4 6180.1 6184.8 5958.3 6033.0 6099.3 6130.7 6197.4 4810.3 4840.7 4881.9 4886.8 4903.9 4329.8 4339.2 4341.8 4345.8 4374.6 5465.3 5542.3 5573.4 5587.5 5640.7 6102.8 6137.8 6224.3 6242.3 6250.9 5506.1 5568.2 5581.1 5584.7 5614.9 5204.6 5309.7 5315.6 5337.2 5343.4 6277.5 6280.3 6349.4 6365.9 6372.4 5159.2 6181.0 6189.4 6189.8 6193.6 6340.4 6356.4 6380.1 6392.1 6396.1 5947.3 6038.7 6042.2 6078.2 6123.5 6162.0 6163.6 6206.2 6219.0 6223.3 5936.3 6011.3 6018.7 6021.0 6057.3 5717.7 5863.0 5952.3 6028.6 6100.8 5233.3 5864.8 5871.7 5878.1 5884.6 6003.4 6006.3 6015.5 6016.9 6017.6 5737.0 5815.4 5817.1 5821.4 5911.3 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:60369.81 Median:36146.32 stddev:120746.98 (334.1%) stddev-sans-first:121002.02 16:21:40 INFO - PROCESS | 1664 | Values: 492.0 523.8 577.8 633.2 635.0 30853.7 31399.8 31408.2 31454.2 31495.4 32047.0 40906.0 41230.4 41257.0 41298.4 8628.9 9567.3 9606.0 9721.8 9772.9 9595.5 9730.6 9735.0 9756.4 9773.1 9706.2 9795.5 9807.1 9809.2 9810.7 9681.4 9909.9 9931.1 9933.1 9935.9 8289.3 9824.9 9825.8 9829.9 9846.4 34442.8 42686.1 42725.1 42774.9 42780.6 3284.0 3286.4 3417.3 3425.9 3490.7 29649.7 29819.6 30218.4 30642.1 30772.7 2783.2 2813.2 2830.0 2857.0 2869.2 470849.3 471167.0 472029.6 472295.0 472462.0 59548.7 68734.0 69294.7 74835.6 75636.0 65831.7 72049.0 72105.3 72111.0 72141.0 16884.7 17308.4 17320.2 17322.2 17370.7 13016.7 13118.0 13120.7 13124.6 13155.9 17554.7 21182.0 21519.5 21643.9 21691.6 7256.1 7398.5 8732.4 8764.4 8830.3 1008.3 1022.7 1065.4 1110.7 1166.4 26444.2 29691.7 29730.7 30309.7 30490.7 877.8 1113.7 1153.6 1191.6 1195.1 11529.8 15116.8 15182.9 15386.0 15465.3 501777.0 513659.0 514653.0 515597.0 520018.0 60153.0 60383.7 60395.4 60459.0 60585.7 1277.6 1358.3 1476.6 1492.1 1515.7 24563.5 28713.0 29325.6 29791.3 30157.7 49341.8 49892.5 50167.0 50387.0 50468.2 364212.0 366542.0 366768.0 367229.2 367875.0 29403.0 32748.9 33424.0 34279.7 34380.7 42168.0 42428.2 42871.8 43144.6 43721.1 34989.8 35198.3 35526.6 36225.0 36288.6 34343.0 34467.5 35112.6 35202.3 35301.5 36065.6 36067.6 36406.6 37019.8 37046.8 31432.7 32150.7 32317.5 32717.0 33241.5 21446.4 23551.6 23973.4 24073.5 24332.9 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:32887.58 Median:365.60 stddev:100007.32 (27354.4%) stddev-sans-first:100257.99 16:21:40 INFO - PROCESS | 1664 | Values: 331.1 358.3 361.0 362.8 368.4 19175.1 19503.9 20712.4 21071.7 21161.7 19874.0 20134.5 20353.0 21089.5 21180.5 5741.2 5883.9 5963.6 5980.4 5996.2 4215.8 4274.7 5226.5 5935.7 6524.8 6427.5 6468.5 6469.4 6474.5 6482.4 5640.7 5887.8 5915.8 5924.0 6401.0 3816.8 4860.9 5470.3 5638.4 5717.8 13247.3 13462.8 13481.7 15174.2 24527.6 2041.2 2135.3 2144.2 2229.4 2607.7 9596.5 9696.9 9710.0 9935.8 10323.6 1722.9 1773.9 1797.7 1809.9 1855.1 94122.1 96137.5 101328.0 101445.5 101829.0 8884.7 10967.6 11172.4 11354.1 11382.3 11994.5 13099.6 13687.9 13692.9 13733.5 8406.1 8546.1 8577.5 8623.9 8628.5 8688.7 8715.0 8732.4 8791.8 8801.9 4445.8 4521.1 4521.4 4591.6 4619.1 1839.7 1886.7 1897.2 1913.7 1935.6 757.8 923.8 949.8 990.3 1009.6 19640.9 19885.5 20141.4 20235.1 20277.6 957.5 957.8 980.2 986.3 992.2 10723.6 10973.2 10987.1 10990.0 11012.0 572818.0 608823.0 610455.0 610893.9 625973.0 66273.0 103355.0 106282.8 106292.5 107589.5 933.3 1040.5 1043.8 1073.4 1094.6 17833.3 17833.6 18159.9 18433.5 18460.7 46491.8 47390.5 48150.2 48298.8 50303.5 64174.7 65236.7 65954.3 66197.0 68047.7 7672.0 7740.9 7822.9 7830.1 7864.3 9102.5 11685.5 12161.9 12333.3 12458.0 9908.3 10464.1 10826.4 10911.2 11001.7 10277.8 10373.3 10533.8 10695.4 10755.4 5964.0 8455.6 10665.6 10829.5 11029.9 7407.5 7626.4 7654.7 7690.6 8137.6 8157.8 10046.9 10585.0 10752.0 10897.5 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6081.65 Median:5448.09 stddev:3221.02 (59.1%) stddev-sans-first:3211.37 16:21:40 INFO - PROCESS | 1664 | Values: 1465.9 1605.8 1635.4 1934.4 2049.7 8046.2 8620.2 8754.0 8770.1 8790.1 8611.9 8839.4 8839.9 8844.2 8854.3 2205.0 2439.9 2485.9 2500.5 2524.4 2510.6 2510.8 2518.9 2525.6 2527.5 2430.8 2457.0 2471.6 2474.0 2477.9 2412.7 2466.9 2477.3 2482.0 2484.3 2438.2 2442.9 2462.9 2477.0 2483.8 8812.2 8866.2 8898.3 8903.9 8924.4 5381.1 5544.4 5586.4 5587.1 5592.3 2944.1 3587.5 3611.2 3649.5 3657.5 1033.1 1047.4 1048.3 1052.6 1059.9 12078.0 12080.5 12088.7 12102.2 12114.2 4855.7 4884.5 5015.0 5026.6 5035.7 10278.8 10304.5 10360.3 10384.9 10406.5 5515.1 5567.8 5574.5 5584.4 5586.9 4505.8 4609.8 4701.6 4855.6 4861.3 3929.7 4013.8 4037.3 4059.7 4088.6 1310.6 1312.8 1318.1 1324.1 1328.7 1390.9 1404.9 1407.8 1433.7 1436.8 8283.0 8395.9 8412.9 8426.0 8439.4 505.3 514.6 514.7 515.5 516.9 6308.3 6359.7 6361.1 6367.4 6373.5 10234.6 10847.2 10862.2 10997.7 11005.8 10434.8 10684.7 10733.9 10765.4 10861.0 8402.1 8410.9 8467.9 8551.3 8571.7 7851.2 8034.3 8045.1 8054.7 8152.2 7480.2 9073.9 9330.0 9402.1 9484.0 9469.1 9678.2 9751.9 9833.8 9998.9 6867.8 7080.9 7265.4 7527.2 7667.8 8354.3 8403.0 8408.5 8432.9 8437.3 6492.0 7426.4 7442.6 7540.0 7605.3 7253.7 7300.7 7353.6 7427.6 7483.2 7728.5 7814.7 7817.8 7829.2 7861.6 6687.6 7004.9 7057.8 7083.6 7084.2 6896.8 6976.3 6980.3 6986.9 7038.5 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:5764.23 Median:6548.51 stddev:1865.39 (28.5%) stddev-sans-first:1825.42 16:21:40 INFO - PROCESS | 1664 | Values: 326.2 330.2 334.4 336.3 339.8 5302.4 5363.6 6549.2 6641.4 6645.0 6015.2 6623.9 6644.6 6650.7 6665.1 4684.1 4811.2 4822.9 4856.7 4935.3 4790.7 4857.9 4868.6 4877.9 4879.4 4814.6 4819.7 4840.1 4840.3 4841.3 3902.6 3976.5 4768.2 4809.2 4809.2 3989.3 4063.5 4149.6 4158.3 4161.5 5237.2 6211.9 6290.2 6334.4 6342.6 5710.0 5711.0 5722.5 5813.4 5825.8 6060.0 7063.7 7085.6 7090.4 7106.1 4506.4 4671.7 4677.9 4685.5 4685.7 7163.4 7422.5 7441.3 7444.4 7455.5 4497.7 4614.4 4628.1 4628.1 4642.9 4706.0 4712.6 4713.2 4715.7 4720.1 5598.0 5605.2 5608.3 5609.9 5614.7 6882.7 7157.4 7163.8 7178.2 7178.7 1607.8 1608.4 1626.5 1629.1 1629.4 1023.4 1025.5 1031.7 1043.4 1046.5 6284.1 6476.8 6483.0 6547.8 6624.5 5919.4 7239.8 7327.5 7412.3 7422.4 6525.0 6550.7 6680.2 6681.4 6683.7 3860.4 3900.9 3910.8 3912.4 3917.5 7425.3 7696.1 7731.5 7734.3 7740.1 7610.8 7656.3 7662.3 7669.7 7675.1 7696.3 7706.5 7710.6 7720.8 7721.6 6649.9 7341.4 7360.7 7367.4 7368.8 5987.3 6866.6 7281.9 7286.8 7296.1 7661.7 7698.7 7705.5 7705.7 7718.0 4599.8 4604.7 4609.2 4609.2 4612.3 7335.8 7341.4 7343.4 7343.9 7344.9 6837.9 7109.0 7114.5 7135.1 7149.7 7070.4 7112.7 7115.8 7129.8 7134.4 6948.5 6980.2 6982.6 6989.1 7019.0 6857.2 7120.6 7136.6 7141.8 7147.0 6659.7 6925.9 6940.2 6967.3 6973.6 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17927.33 Median:33243.49 stddev:25452.29 (76.6%) stddev-sans-first:25490.80 16:21:40 INFO - PROCESS | 1664 | Values: 692.7 748.7 749.8 758.5 772.8 15135.7 15352.2 15353.3 15378.9 15382.4 13797.8 14182.4 14210.9 14215.1 14224.3 743.3 754.4 764.4 937.2 939.5 926.1 950.8 950.8 951.9 952.1 982.5 984.5 986.8 987.1 991.7 784.0 824.4 977.6 977.6 989.8 725.9 726.4 726.8 729.7 732.8 14999.5 15055.2 15058.5 15081.7 15083.0 12509.1 12554.2 12630.6 12804.1 12911.1 9931.8 10180.2 10871.0 10908.5 11251.9 3523.7 3722.9 3727.0 4420.3 4443.7 72523.0 73467.0 74240.0 74350.0 74519.6 9269.8 9355.0 9534.3 9542.2 10019.1 22018.3 22020.4 22031.9 22069.4 22079.0 6519.7 6728.1 6837.9 6854.7 6891.7 3851.5 3908.4 3912.5 3912.8 3920.6 3689.0 3737.0 3741.7 3741.8 3743.2 649.6 660.0 663.7 669.0 691.2 537.2 579.9 589.5 595.5 616.1 7907.2 8016.2 8071.8 8072.8 8110.7 460.4 473.0 575.3 598.5 600.6 3780.5 3799.2 3808.7 3913.2 3973.9 93037.5 94567.0 95769.5 95947.5 97644.0 67116.0 72192.0 79642.6 79822.6 80029.0 70573.6 70769.9 70780.0 71183.3 72418.0 7114.4 7426.7 7453.2 7603.0 7697.9 49481.8 50838.5 51122.7 51144.0 52021.2 55402.0 65564.3 65827.0 70439.0 71995.3 7990.4 10229.2 10269.6 10377.4 10807.6 10120.1 10230.1 10240.4 10241.3 10712.4 10192.9 10264.3 10562.7 10569.9 10590.0 8459.9 8813.2 10153.0 10315.9 10678.6 9956.8 10325.8 10374.0 10476.7 10740.9 8824.7 8836.1 8852.8 8863.1 9094.0 8201.4 8871.5 8943.1 8957.4 9094.2 16:21:40 INFO - PROCESS | 1664 | -------- Summary: end -------- 16:21:40 INFO - PROCESS | 1664 | 16:21:40 INFO - TEST-INFO | 1664: exit 0 16:21:40 INFO - TEST-OK | dromaeo_css | took 1114212ms 16:21:40 INFO - TEST-START | kraken 16:21:40 INFO - operating with platform_type : mac_ 16:21:40 INFO - Initialising browser for kraken test... 16:21:40 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp4NIGY2/profile http://localhost:49270/getInfo.html) 16:21:42 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 16:21:42 INFO - PROCESS | 1674 | colorDepth:24 16:21:42 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 16:21:42 INFO - PROCESS | 1674 | __metrics 16:21:43 INFO - PROCESS | 1674 | 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:21:43 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:21:43 INFO - TEST-INFO | 1674: exit 0 16:21:43 INFO - Browser initialized. 16:21:43 INFO - Running cycle 1/1 for kraken test... 16:21:43 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmp4NIGY2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:55 INFO - PROCESS | 1676 | RSS: Main: 247484416 16:21:55 INFO - PROCESS | 1676 | 16:21:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:21:58 INFO - PROCESS | 1676 | RSS: Main: 291966976 16:21:58 INFO - PROCESS | 1676 | 16:22:01 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:22:01 INFO - PROCESS | 1676 | RSS: Main: 303366144 16:22:01 INFO - PROCESS | 1676 | 16:22:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:22:05 INFO - PROCESS | 1676 | RSS: Main: 291442688 16:22:05 INFO - PROCESS | 1676 | 16:22:07 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:22:08 INFO - PROCESS | 1676 | RSS: Main: 293474304 16:22:08 INFO - PROCESS | 1676 | 16:22:10 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:22:10 INFO - PROCESS | 1676 | RSS: Main: 294326272 16:22:10 INFO - PROCESS | 1676 | 16:22:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:22:14 INFO - PROCESS | 1676 | RSS: Main: 294563840 16:22:14 INFO - PROCESS | 1676 | 16:22:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:17 INFO - PROCESS | 1676 | RSS: Main: 294420480 16:22:17 INFO - PROCESS | 1676 | 16:22:20 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:22:21 INFO - PROCESS | 1676 | RSS: Main: 293523456 16:22:21 INFO - PROCESS | 1676 | 16:22:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:23 INFO - PROCESS | 1676 | RSS: Main: 327045120 16:22:23 INFO - PROCESS | 1676 | 16:22:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:25 INFO - PROCESS | 1676 | RSS: Main: 325681152 16:22:25 INFO - PROCESS | 1676 | 16:22:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:28 INFO - PROCESS | 1676 | RSS: Main: 332140544 16:22:28 INFO - PROCESS | 1676 | 16:22:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:31 INFO - PROCESS | 1676 | RSS: Main: 334495744 16:22:31 INFO - PROCESS | 1676 | 16:22:34 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:34 INFO - PROCESS | 1676 | RSS: Main: 335073280 16:22:34 INFO - PROCESS | 1676 | 16:22:36 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:22:37 INFO - PROCESS | 1676 | RSS: Main: 394678272 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | __start_tp_report 16:22:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 16:22:37 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 16:22:37 INFO - PROCESS | 1676 | |i|pagename|runs| 16:22:37 INFO - PROCESS | 1676 | |0;ai-astar;112;109;110;111;111;111;116;111;110;110 16:22:37 INFO - PROCESS | 1676 | |1;audio-beat-detection;155;124;143;158;120;143;135;129;160;116 16:22:37 INFO - PROCESS | 1676 | |2;audio-dft;184;186;184;186;190;187;184;186;204;168 16:22:37 INFO - PROCESS | 1676 | |3;audio-fft;74;78;83;79;56;58;57;81;76;55 16:22:37 INFO - PROCESS | 1676 | |4;audio-oscillator;91;95;133;81;77;84;116;78;80;119 16:22:37 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;87;86;96;131;113;84;89;86;89;85 16:22:37 INFO - PROCESS | 1676 | |6;imaging-darkroom;92;93;94;93;93;93;93;94;93;92 16:22:37 INFO - PROCESS | 1676 | |7;imaging-desaturate;85;85;84;96;145;136;84;84;86;88 16:22:37 INFO - PROCESS | 1676 | |8;json-parse-financial;57;56;53;53;54;55;54;64;56;53 16:22:37 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;65;67;81;73;71;66;68;68;67;68 16:22:37 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;83;82;83;83;95;108;79;81;83;83 16:22:37 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;122;136;132;144;125;104;127;131;128;135 16:22:37 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;136;134;139;173;178;169;148;141;142;173 16:22:37 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;67;66;76;93;95;94;67;68;66 16:22:37 INFO - PROCESS | 1676 | __end_tp_report 16:22:37 INFO - PROCESS | 1676 | __start_cc_report 16:22:37 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1248 16:22:37 INFO - PROCESS | 1676 | __end_cc_report 16:22:37 INFO - PROCESS | 1676 | __startTimestamp1458688957017__endTimestamp 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | ------- Summary: start ------- 16:22:37 INFO - PROCESS | 1676 | Number of tests: 14 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 16:22:37 INFO - PROCESS | 1676 | Values: 112.0 109.0 110.0 111.0 111.0 111.0 116.0 111.0 110.0 110.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:143.00 stddev:16.04 (11.2%) stddev-sans-first:15.84 16:22:37 INFO - PROCESS | 1676 | Values: 155.0 124.0 143.0 158.0 120.0 143.0 135.0 129.0 160.0 116.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:185.90 Median:186.00 stddev:8.67 (4.7%) stddev-sans-first:9.17 16:22:37 INFO - PROCESS | 1676 | Values: 184.0 186.0 184.0 186.0 190.0 187.0 184.0 186.0 204.0 168.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:69.70 Median:77.00 stddev:11.64 (15.1%) stddev-sans-first:12.25 16:22:37 INFO - PROCESS | 1676 | Values: 74.0 78.0 83.0 79.0 56.0 58.0 57.0 81.0 76.0 55.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.50 stddev:20.08 (24.9%) stddev-sans-first:21.24 16:22:37 INFO - PROCESS | 1676 | Values: 91.0 95.0 133.0 81.0 77.0 84.0 116.0 78.0 80.0 119.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:86.50 stddev:15.41 (17.8%) stddev-sans-first:16.10 16:22:37 INFO - PROCESS | 1676 | Values: 87.0 86.0 96.0 131.0 113.0 84.0 89.0 86.0 89.0 85.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 16:22:37 INFO - PROCESS | 1676 | Values: 92.0 93.0 94.0 93.0 93.0 93.0 93.0 94.0 93.0 92.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:85.00 stddev:23.15 (27.2%) stddev-sans-first:24.12 16:22:37 INFO - PROCESS | 1676 | Values: 85.0 85.0 84.0 96.0 145.0 136.0 84.0 84.0 86.0 88.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:3.31 (6.0%) stddev-sans-first:3.46 16:22:37 INFO - PROCESS | 1676 | Values: 57.0 56.0 53.0 53.0 54.0 55.0 54.0 64.0 56.0 53.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:68.00 stddev:4.70 (6.9%) stddev-sans-first:4.70 16:22:37 INFO - PROCESS | 1676 | Values: 65.0 67.0 81.0 73.0 71.0 66.0 68.0 68.0 67.0 68.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.00 stddev:8.82 (10.6%) stddev-sans-first:9.29 16:22:37 INFO - PROCESS | 1676 | Values: 83.0 82.0 83.0 83.0 95.0 108.0 79.0 81.0 83.0 83.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.50 stddev:10.62 (8.1%) stddev-sans-first:11.01 16:22:37 INFO - PROCESS | 1676 | Values: 122.0 136.0 132.0 144.0 125.0 104.0 127.0 131.0 128.0 135.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:158.50 stddev:17.69 (11.2%) stddev-sans-first:17.62 16:22:37 INFO - PROCESS | 1676 | Values: 136.0 134.0 139.0 173.0 178.0 169.0 148.0 141.0 142.0 173.0 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:72.00 stddev:12.83 (17.8%) stddev-sans-first:13.20 16:22:37 INFO - PROCESS | 1676 | Values: 67.0 67.0 66.0 76.0 93.0 95.0 94.0 67.0 68.0 66.0 16:22:37 INFO - PROCESS | 1676 | -------- Summary: end -------- 16:22:37 INFO - PROCESS | 1676 | 16:22:37 INFO - TEST-INFO | 1676: exit 0 16:22:37 INFO - TEST-OK | kraken | took 57141ms 16:22:37 INFO - SUITE-END | took 1171s 16:22:38 INFO - Completed test suite (00:19:31) 16:22:38 INFO - javascript benchmark 16:22:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3444.328355970586, 3492.493588429678, 3518.278752855665, 3528.9647103528955, 3571.357155711971, 5561.833145005657, 5603.467670571295, 5608.831735047945, 5622.7188640567965, 5677.659340439576, 4600.493945665974, 5656.095024796034, 5667.688277144755, 5783.306003279612, 5797.072468405056, 5047.293378926953, 5070.391553013635, 5089.923651145235, 5098.796048158069, 5232.241325007891, 5204.9739751301195, 5249.8950020999555, 5266.710330931797, 5318.1225097858805, 5327.520523152915, 5041.017001684673, 5132.101882170643, 5140.228965655144, 5158.432572417031, 5208.348956380452, 5120.308758317617, 5123.718195499246, 5136.768845401966, 5139.7687104080405, 5142.04872098663, 5088.974555127238, 5130.71781052042, 5148.61385396093, 5151.587872970191, 5178.508041736029, 5482.780688772445, 5486.698231597261, 5502.8349149525575, 5514.889702205974, 5537.363203231599, 5981.312149102865, 6075.848103797396, 6083.209182806251, 6107.328193898667, 6112.174856394418, 6069.9947200111965, 6086.249307700361, 6102.847428814271, 6133.264008318985, 6140.105498721233, 5669.43305669438, 5716.685582292972, 5755.884882302331, 5783.855403614902, 5805.651660900359, 5552.86117847049, 6333.873322533524, 6343.714532846033, 6357.364263573698, 6371.840703982345, 5878.588498805128, 5958.851028724316, 6037.456628903332, 6045.576809623372, 6051.667158306247, 6110.042400473247, 6191.0, 6217.564770466024, 6219.844503887439, 6222.408871157233, 6147.72335244915, 6151.384861513813, 6159.353267906805, 6180.072989051679, 6184.752609895644, 5958.314793798682, 6032.969835150796, 6099.298580663191, 6130.662813545208, 6197.411245931629, 4810.278458231223, 4840.661153719206, 4881.8535443936735, 4886.780094895738, 4903.926441103386, 4329.76186309756, 4339.218940590724, 4341.82632694695, 4345.847895323712, 4374.562543745664, 5465.316835395575, 5542.307211598551, 5573.359063707644, 5587.525060369914, 5640.746166422521, 6102.792231004478, 6137.8060289513105, 6224.284207316216, 6242.313345531988, 6250.874982500324, 5506.063969125178, 5568.192612071308, 5581.134924086773, 5584.692841893735, 5614.9157762633595, 5204.635675502678, 5309.7079660618265, 5315.6279060465395, 5337.226102215157, 5343.385510666323, 6277.466415354746, 6280.309165991737, 6349.428551430394, 6365.904511432424, 6372.394622510854, 5159.2003239497935, 6181.0, 6189.412005859436, 6189.752409903734, 6193.597416167935, 6340.365963403623, 6356.364363563606, 6380.1067850501895, 6392.073149393219, 6396.104545363746, 5947.256592925884, 6038.69806509664, 6042.184305118929, 6078.209832721718, 6123.540734445023, 6162.044883043135, 6163.598755970808, 6206.224221972254, 6219.036049412348, 6223.315435302023, 5936.28764548257, 6011.338752737282, 6018.699065046818, 6020.969895150496, 6057.273127224761, 5717.685527296038, 5862.970685146547, 5952.285725712769, 6028.57799953999, 6100.786472473442, 5233.267342571967, 5864.794732184353, 5871.706414679164, 5878.118282257525, 5884.58807883444, 6003.369646187088, 6006.309274433496, 6015.488683461955, 6016.8796624068145, 6017.578769486094, 5736.971315143398, 5815.41845815415, 5817.127430885401, 5821.417858214145, 5911.290645122613], "unit": "score", "name": "dojo.html", "value": 5621.947736595608}, {"lowerIsBetter": false, "replicates": [491.9619602638434, 523.8418846981538, 577.8270111673302, 633.170546583975, 635.0379175549044, 30853.69146308539, 31399.843000785022, 31408.214794630116, 31454.213644658867, 31495.370092598136, 32047.0, 40905.97735056625, 41230.38154427686, 41257.0, 41298.38052429216, 8628.913710862873, 9567.282453815975, 9606.0, 9721.805563888718, 9772.902270977305, 9595.472249026301, 9730.610775569005, 9735.026497350244, 9756.41461512308, 9773.07155820196, 9706.174975127122, 9795.461249631267, 9807.117359437649, 9809.21526277896, 9810.70567882961, 9681.419114853132, 9909.90090099097, 9931.106200441995, 9933.10602045812, 9935.850962235609, 8289.295409890166, 9824.852627210597, 9825.803483930353, 9829.852552211723, 9846.359986600919, 34442.82778586091, 42686.14627707459, 42725.145497089885, 42774.93062673427, 42780.57219427797, 3283.9835800820842, 3286.4413049781597, 3417.3165366926464, 3425.8972230833115, 3490.685838274542, 29649.70350296491, 29819.552706709415, 30218.395632087235, 30642.080737577908, 30772.692273077206, 2783.1789622061337, 2813.198238502017, 2829.9858500707364, 2857.0286102724967, 2869.196624945019, 470849.2915070874, 471167.0, 472029.63985180197, 472295.0, 472462.0, 59548.70225648844, 68734.0, 69294.65352673305, 74835.62582187055, 75636.0, 65831.67084164644, 72049.0, 72105.2789472109, 72111.0, 72141.0, 16884.662306753795, 17308.394206202975, 17320.220590073477, 17322.22050007753, 17370.697197710222, 13016.739665206644, 13118.016148788878, 13120.737585248433, 13124.60626181197, 13155.947524198042, 17554.66461372335, 21182.046807893683, 21519.46201344979, 21643.891780541, 21691.566168676854, 7256.0567126273245, 7398.482106252618, 8732.388732788644, 8764.386492945432, 8830.293576513863, 1008.3496144986443, 1022.7085280694967, 1065.3927261460892, 1110.6949334531894, 1166.4284500594647, 26444.206673799818, 29691.703082968892, 29730.702692972794, 30309.69690303113, 30490.695093048784, 877.7893305606608, 1113.6770336602294, 1153.5616465742964, 1191.5948577483698, 1195.0857593940643, 11529.769404611861, 15116.848831511545, 15182.924085379724, 15386.0, 15465.304061317267, 501777.0, 513659.0, 514653.0, 515597.0, 520018.0, 60153.0, 60383.69808151019, 60395.39604603898, 60459.0, 60585.69707151436, 1277.572013375511, 1358.3276278242333, 1476.5865557643876, 1492.060002198608, 1515.7347464193722, 24563.508729824945, 28713.0, 29325.56011659784, 29791.25521861884, 30157.69842301549, 49341.75329123331, 49892.50107498879, 50167.0, 50387.0, 50468.22424766526, 364212.0, 366542.0, 366768.0, 367229.16385417903, 367875.0, 29403.0, 32748.85379011723, 33424.0, 34279.65720342765, 34380.656193437746, 42168.0, 42428.151436971704, 42871.7856410716, 43144.56855431406, 43721.12557748891, 34989.77535786235, 35198.296034079685, 35526.64473355337, 36225.0, 36288.63711362958, 34342.969710908714, 34467.482987755706, 35112.64887351094, 35202.29595408026, 35301.47047794234, 36065.639343607276, 36067.639323606425, 36406.635933640326, 37019.8149009264, 37046.814765926, 31432.68567314389, 32150.678493215702, 32317.51523727193, 32717.0, 33241.50137747984, 21446.356609301747, 23551.646725298793, 23973.400664983514, 24073.51852962896, 24332.87833560821], "unit": "score", "name": "ext.html", "value": 19646.64666189938}, {"lowerIsBetter": false, "replicates": [331.1373871065873, 358.3102527634304, 361.04503588009715, 362.7569528415961, 368.4399712437094, 19175.13711882965, 19503.927283999376, 20712.378628641163, 21071.683924741104, 21161.68257476135, 19874.006299685032, 20134.496637584067, 20352.982350882434, 21089.47276318093, 21180.470488237803, 5741.19623252746, 5883.88232235355, 5963.61236519627, 5980.401959804029, 5996.160537524728, 4215.768132752697, 4274.722143060707, 5226.503482169188, 5935.673537955411, 6524.804255872307, 6427.485801135898, 6468.4825213983, 6469.4177524022825, 6474.546781725281, 6482.448991835699, 5640.717964101799, 5887.7939272125695, 5915.792947246847, 5924.0, 6400.967995160017, 3816.8091595420397, 4860.878478038042, 5470.316210473691, 5638.407967163471, 5717.828465146011, 13247.337633118306, 13462.798058029137, 13481.662958426019, 15174.24128793556, 24527.632085518733, 2041.2007296375582, 2135.29535253366, 2144.1530595414724, 2229.4314949687887, 2607.7261887501727, 9596.472194029326, 9696.903030969741, 9709.977897851215, 9935.801283974351, 10323.63867264642, 1722.8793984421095, 1773.8935663860082, 1797.7213531902576, 1809.9276028958825, 1855.1466325490292, 94122.0587794127, 96137.51931240299, 101328.0, 101445.4927725364, 101829.0, 8884.73345799627, 10967.616133435291, 11172.385518796544, 11354.148438866952, 11382.260153090188, 11994.520219191309, 13099.607011789662, 13687.863121368859, 13692.931535342259, 13733.45066197361, 8406.117357677478, 8546.05993340732, 8577.485350878967, 8623.913760862311, 8628.52543110135, 8688.695895643623, 8715.041345451995, 8732.388732788771, 8791.780205494786, 8801.911980880237, 4445.755483448376, 4521.073179998092, 4521.367008618796, 4591.563801438858, 4619.076184763061, 1839.705647096458, 1886.7075603281514, 1897.1557656842572, 1913.6651086059883, 1935.6225536020622, 757.8105473631592, 923.8106188231396, 949.8052899155656, 990.2919412620012, 1009.5507499162802, 19640.901795491216, 19885.502862428555, 20141.39575812728, 20235.089420975797, 20277.59444811125, 957.4733896357116, 957.760559860035, 980.2060331131663, 986.2652324018652, 992.156666833186, 10723.624673136559, 10973.231873768918, 10987.121030317556, 10990.0, 11012.0, 572818.0, 608823.0, 610455.0, 610893.8910610926, 625973.0, 66273.0, 103355.0, 106282.75381089997, 106292.46853765682, 107589.46205268924, 933.2533972821716, 1040.5369610523396, 1043.8068957242933, 1073.355986408149, 1094.5621751299384, 17833.286668533114, 17833.643327133126, 18159.914019345542, 18433.53916152107, 18460.723089153944, 46491.76754116208, 47390.52609473861, 48150.16457965988, 48298.75850620725, 50303.49696502988, 64174.67912660407, 65236.69526609346, 65954.34045659674, 66197.0, 68047.65976170088, 7672.0, 7740.883886741816, 7822.882656760039, 7830.1386847447875, 7864.252895974873, 9102.544872756203, 11685.474153662935, 12161.939190303992, 12333.260004399765, 12458.00335973102, 9908.256880734118, 10464.110550603284, 10826.40454774995, 10911.236213464981, 11001.724956876142, 10277.84583231267, 10373.273870828969, 10533.789324213627, 10695.358278503003, 10755.408452535186, 5964.045752679551, 8455.619497122521, 10665.626703065356, 10829.512671929624, 11029.897010298906, 7407.481476296607, 7626.436580500873, 7654.693812247448, 7690.577018264049, 8137.552434615916, 8157.796055098433, 10046.899531004596, 10584.994425529563, 10752.0, 10897.455127243764], "unit": "score", "name": "jquery.html", "value": 9042.507844587104}, {"lowerIsBetter": false, "replicates": [1465.9193744344057, 1605.7591361295804, 1635.386729976259, 1934.4003358958714, 2049.682299243617, 8046.235607617275, 8620.181082797131, 8754.0, 8770.079141690127, 8790.077041910596, 8611.91388086119, 8839.425437346568, 8839.867401988975, 8844.204021638052, 8854.33592480565, 2204.9559008819815, 2439.9390015249583, 2485.850848949064, 2500.5374005808894, 2524.356289146265, 2510.6108553174195, 2510.7991360691194, 2518.899244030237, 2525.5959046552557, 2527.4692314613953, 2430.80553555716, 2456.987715061431, 2471.5798314286526, 2474.0, 2477.8973356856204, 2412.7225369082516, 2466.8889899954547, 2477.306354220821, 2482.0, 2484.254723582918, 2438.2197696737053, 2442.8778561072054, 2462.8522288662557, 2476.9752302476923, 2483.8385504942303, 8812.16284452976, 8866.202041816203, 8898.332625053146, 8903.866442003375, 8924.419912705718, 5381.0583147948955, 5544.417836127229, 5586.41342659019, 5587.1339942309005, 5592.328920529562, 2944.1461976026926, 3587.515685382466, 3611.205534782344, 3649.5073165122635, 3657.4696668982847, 1033.137330329176, 1047.4134484688598, 1048.308116643012, 1052.5686262783304, 1059.8728152621734, 12078.0, 12080.456379462945, 12088.697782555506, 12102.152849300552, 12114.152009359348, 4855.732934688626, 4884.462709101996, 5014.997000599895, 5026.597872170218, 5035.697858128524, 10278.794424111476, 10304.484775761182, 10360.326578772356, 10384.948075259575, 10406.479676016168, 5515.117581186991, 5567.805126820623, 5574.526165275915, 5584.385717571064, 5586.944130558723, 4505.797239124247, 4609.7695115244105, 4701.6003639690325, 4855.587275081658, 4861.29511220871, 3929.6856251500385, 4013.7591744495426, 4037.253108174997, 4059.6955228357992, 4088.632023117934, 1310.5740634293702, 1312.7571399291162, 1318.0773458578842, 1324.0863803975226, 1328.6611913961879, 1390.9095908765898, 1404.894632902516, 1407.7536431124513, 1433.6989232261342, 1436.827580690303, 8283.0, 8395.874061889077, 8412.873806892901, 8425.988881334279, 8439.367047471464, 505.29511331692083, 514.565192412411, 514.7323391836225, 515.5257163409672, 516.8501134670903, 6308.337624549448, 6359.650219237894, 6361.077643741724, 6367.42693157618, 6373.458256048195, 10234.6417875374, 10847.186461015455, 10862.239643225057, 10997.725056873482, 11005.834912476319, 10434.791304174027, 10684.679459616069, 10733.946330268298, 10765.407902565434, 10861.02250797432, 8402.117777633383, 8410.87383689233, 8467.915320846836, 8551.315894728406, 8571.742847714579, 7851.175626559358, 8034.276915077671, 8045.07481639619, 8054.677812887418, 8152.184781521801, 7480.177180510031, 9073.863892041756, 9329.953350233205, 9402.106799854002, 9484.0, 9469.053094690476, 9678.225741940487, 9751.902480975099, 9833.754156146153, 9998.850017249893, 6867.828304292432, 7080.858382832212, 7265.382442492447, 7527.247275272429, 7667.846643066996, 8354.331653467829, 8403.0, 8408.495490270603, 8432.873506897278, 8437.325013998989, 6491.967540162269, 7426.443016773872, 7442.553446793209, 7540.019797426299, 7605.277498637621, 7253.673584688807, 7300.707971681073, 7353.558786472829, 7427.554346739213, 7483.214262502359, 7728.45900786962, 7814.6874125034365, 7817.843643126992, 7829.1779363168325, 7861.646225919962, 6687.565308254948, 7004.859902802017, 7057.788266352018, 7083.610401427971, 7084.185318688416, 6896.793096207121, 6976.337247961435, 6980.336867997532, 6986.895196572157, 7038.507304488637], "unit": "score", "name": "mootools.html", "value": 4883.647412319662}, {"lowerIsBetter": false, "replicates": [326.20243504631173, 330.24044697196456, 334.44649105730025, 336.2853935387302, 339.80970656432385, 5302.390225124112, 5363.570914326854, 6549.214094308678, 6641.435477984371, 6645.0364697118885, 6015.157877897098, 6623.90064149037, 6644.568103073297, 6650.7339706411685, 6665.133532640762, 4684.110019096361, 4811.158047341719, 4822.937434728955, 4856.708597484145, 4935.3337299464565, 4790.736509491977, 4857.878553036185, 4868.634852386068, 4877.8780530486665, 4879.438864530571, 4814.614830813544, 4819.710817350952, 4840.104580652573, 4840.322354870321, 4841.3222148899185, 3902.551206611219, 3976.4631774710624, 4768.213244814601, 4809.158397280462, 4809.182438985381, 3989.341758609826, 4063.451434056394, 4149.564295748933, 4158.272302347107, 4161.52142503613, 5237.214417837316, 6211.875762484725, 6290.24517057956, 6334.398232167937, 6342.619442833445, 5710.0, 5710.971445142748, 5722.54219662426, 5813.389594092644, 5825.796097136622, 6060.000099983497, 7063.682134303917, 7085.574865508086, 7090.361867431956, 7106.111736032996, 4506.3916371290115, 4671.743054132022, 4677.88305292367, 4685.484596694361, 4685.688007357945, 7163.355298023151, 7422.517536360173, 7441.2930771576075, 7444.36722878556, 7455.4781165318445, 4497.707649002804, 4614.446266448048, 4628.097520983443, 4628.120657075145, 4642.930356044662, 4705.95294047062, 4712.622990160848, 4713.222318317507, 4715.693479923794, 4720.0559888022535, 5597.972010139923, 5605.243292155588, 5608.327000759935, 5609.887802243932, 5614.6631202128, 6882.724691012303, 7157.4274058075225, 7163.8479069210425, 7178.24628414009, 7178.712851485987, 1607.7588361745597, 1608.4450864451746, 1626.4957863062489, 1629.1121338870344, 1629.39712306445, 1023.4217667018111, 1025.466757286222, 1031.6698656429871, 1043.4000449741277, 1046.4610725476387, 6284.12022316876, 6476.805695829133, 6482.967585162044, 6547.803565893031, 6624.470042396597, 5919.437653422918, 7239.782806515813, 7327.45044121693, 7412.258774122544, 7422.443316751265, 6525.0, 6550.737970481223, 6680.164979377578, 6681.432078273304, 6683.732650694015, 3860.3823388258306, 3900.941485877714, 3910.8240129194255, 3912.4131380292615, 3917.490726205575, 7425.294597013275, 7696.11494678108, 7731.497452665559, 7734.342580880576, 7740.071191456948, 7610.771676849703, 7656.349210317074, 7662.310392064629, 7669.693212271558, 7675.078990521061, 7696.307332339892, 7706.460547761715, 7710.614469276514, 7720.806979825549, 7721.575313357819, 6649.867002659823, 7341.375983041501, 7360.705571777069, 7367.447441441806, 7368.784150615088, 5987.251593550806, 6866.622335771381, 7281.871309946967, 7286.781396558112, 7296.087989001375, 7661.655225514976, 7698.730544430918, 7705.460617756703, 7705.691772329044, 7717.996660434333, 4599.770011499345, 4604.700694454849, 4609.1703493371515, 4609.193391156601, 4612.30815377696, 7335.77992660221, 7341.375983041287, 7343.4492413068165, 7343.8898416522725, 7344.926550734638, 6837.863242735217, 7108.964455177898, 7114.466415018791, 7135.108111486064, 7149.678264478215, 7070.4343652508705, 7112.679929403293, 7115.75094871677, 7129.7861064168155, 7134.393576546052, 6948.478864085113, 6980.197277312971, 6982.615956122462, 6989.126359205099, 7018.964905175441, 6857.245702972768, 7120.643967801693, 7136.643167841691, 7141.750038748619, 7147.0, 6659.733610655519, 6925.896111558432, 6940.167179938439, 6967.268436814062, 6973.58158510491], "unit": "score", "name": "prototype.html", "value": 5140.486277824552}, {"lowerIsBetter": false, "replicates": [692.698676075907, 748.7454265549712, 749.7638243953154, 758.480440897985, 772.7797577690358, 15135.697286054286, 15352.155631440295, 15353.30910109045, 15378.92310538447, 15382.384704611815, 13797.793033104512, 14182.361793719281, 14210.857891421083, 14215.147091174536, 14224.288785560731, 743.2567432567419, 754.4002517998177, 764.3884892086337, 937.1518775508176, 939.5161491831713, 926.1248120526105, 950.752804270891, 950.8240975419535, 951.9476428796413, 952.0859974424561, 982.5234761140841, 984.5274268351196, 986.7730422002944, 987.1461186074066, 991.6727479931641, 783.9921600783977, 824.4476200945381, 977.5698692575244, 977.5698692575244, 989.7822479054596, 725.9491835571512, 726.3680597879826, 726.8182954261434, 729.7445893937132, 732.8021434212786, 14999.475018374415, 15055.171965541891, 15058.54824355271, 15081.698366032728, 15083.019603725723, 12509.06182036351, 12554.246745195318, 12630.557930472389, 12804.103712740112, 12911.096223264376, 9931.789892954941, 10180.185585153169, 10871.0, 10908.454577271104, 11251.887481125166, 3523.7181025518153, 3722.925541489155, 3727.0, 4420.292753159511, 4443.666724995606, 72523.0, 73467.0, 74240.0, 74350.0, 74519.62740186264, 9269.814603708022, 9355.017723139108, 9534.332596718163, 9542.188913942255, 10019.148372388283, 22018.339449816212, 22020.449488762908, 22031.889840551015, 22069.448263793212, 22079.0, 6519.674016299166, 6728.091707619409, 6837.863242735118, 6854.691538880762, 6891.655417229119, 3851.5185601799776, 3908.413737939275, 3912.471816304819, 3912.8043597819997, 3920.6079392060565, 3689.0, 3737.047053001522, 3741.7006639468777, 3741.812909354576, 3743.232637309345, 649.5842660697158, 659.9769008084791, 663.7046514301089, 669.0432681265739, 691.1705952856491, 537.2103008577385, 579.9449052340021, 589.460643511191, 595.5295316699759, 616.0851136062943, 7907.169747176578, 8016.198380161937, 8071.757847264592, 8072.798180045428, 8110.716124935717, 460.41297345884266, 472.99763501182275, 575.2923903598513, 598.5092224376057, 600.5645906717594, 3780.4896338993885, 3799.1831756172555, 3808.7333886628226, 3913.178232571192, 3973.920521589552, 93037.53481232551, 94567.0, 95769.52115239379, 95947.52026239964, 97644.0, 67116.0, 72192.0, 79642.6017869907, 79822.60088699519, 80029.0, 70573.64713176401, 70769.93845092328, 70780.0, 71183.28816711767, 72418.0, 7114.395276401564, 7426.702931882664, 7453.217412171861, 7602.961985190039, 7697.923020769721, 49481.752591236815, 50838.49161508486, 51122.74438627783, 51144.0, 52021.21968170556, 55402.0, 65564.34435655773, 65827.01259481016, 70439.0, 71995.28004719886, 7990.440669153103, 10229.181665466596, 10269.640562580573, 10377.429241391796, 10807.567697292021, 10120.139788118093, 10230.13556204264, 10240.385576865114, 10241.283110182216, 10712.410817405118, 10192.898071019492, 10264.332818366782, 10562.683119506428, 10569.947150264199, 10590.0, 8459.873101903599, 8813.175573352806, 10153.0, 10315.948420257851, 10678.572857085941, 9956.800863982535, 10325.793484130425, 10374.0, 10476.738081548023, 10740.946295268473, 8824.735257942271, 8836.116388361112, 8852.778680533038, 8863.064264180799, 9094.045125261753, 8201.42590018693, 8871.467711937305, 8943.060978597154, 8957.372983891066, 9094.226990705863], "unit": "score", "name": "yui.html", "value": 6752.4732326204885}], "name": "dromaeo_css", "value": 7437.923599932414}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 110.0, 111.0, 111.0, 111.0, 116.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 143.0, 158.0, 120.0, 143.0, 135.0, 129.0, 160.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 138.3}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 184.0, 186.0, 190.0, 187.0, 184.0, 186.0, 204.0, 168.0], "unit": "score", "name": "audio-dft", "value": 185.9}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 83.0, 79.0, 56.0, 58.0, 57.0, 81.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 133.0, 81.0, 77.0, 84.0, 116.0, 78.0, 80.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 95.4}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 96.0, 131.0, 113.0, 84.0, 89.0, 86.0, 89.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 93.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 96.0, 145.0, 136.0, 84.0, 84.0, 86.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 53.0, 53.0, 54.0, 55.0, 54.0, 64.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 81.0, 73.0, 71.0, 66.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 95.0, 108.0, 79.0, 81.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [122.0, 136.0, 132.0, 144.0, 125.0, 104.0, 127.0, 131.0, 128.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [136.0, 134.0, 139.0, 173.0, 178.0, 169.0, 148.0, 141.0, 142.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 76.0, 93.0, 95.0, 94.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.9}], "name": "kraken", "value": 1453.8}]} 16:22:38 INFO - Return code: 0 16:22:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:22:38 ERROR - # TBPL SUCCESS # 16:22:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:22:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:22:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:22:38 INFO - 2016-03-22 16:22:38.350 screenresolution[1680:9692] starting screenresolution argv=screenresolution get 16:22:38 INFO - 2016-03-22 16:22:38.353 screenresolution[1680:9692] Display 0: 1600x1200x32@60 16:22:38 INFO - 2016-03-22 16:22:38.358 screenresolution[1681:9695] starting screenresolution argv=screenresolution list 16:22:38 INFO - Available Modes on Display 0 16:22:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:22:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:22:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:22:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:22:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:22:38 INFO - Intel Iris: 16:22:38 INFO - Chipset Model: Intel Iris 16:22:38 INFO - Type: GPU 16:22:38 INFO - Bus: Built-In 16:22:38 INFO - VRAM (Dynamic, Max): 1536 MB 16:22:38 INFO - Vendor: Intel (0x8086) 16:22:38 INFO - Device ID: 0x0a2e 16:22:38 INFO - Revision ID: 0x0009 16:22:38 INFO - Displays: 16:22:38 INFO - Display: 16:22:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:22:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:22:38 INFO - Display Serial Number: 1600x1200 60 16:22:38 INFO - Main Display: Yes 16:22:38 INFO - Mirror: Off 16:22:38 INFO - Online: Yes 16:22:38 INFO - Rotation: Supported 16:22:38 INFO - Return code: 0 16:22:38 INFO - Running post-action listener: _resource_record_post_action 16:22:38 INFO - Running post-run listener: _resource_record_post_run 16:22:39 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39859712; Write bytes: 705005056; Read time: 421; Write time: 2100 16:22:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398043648; Write bytes: 391149056; Read time: 30637; Write time: 712 16:22:39 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38045184; Write bytes: 299708416; Read time: 401; Write time: 1356 16:22:39 INFO - Running post-run listener: _upload_blobber_files 16:22:39 INFO - Blob upload gear active. 16:22:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:39 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:22:39 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:22:39 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:22:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:22:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:41 INFO - (blobuploader) - INFO - Done attempting. 16:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:42 INFO - (blobuploader) - INFO - Done attempting. 16:22:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:42 INFO - Return code: 0 16:22:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:22:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c27f4ee0bfcba72a9952c6fd1ca47e9b0667aceea1e9ca2b6ff187be1ea6f0b77f23110cb4256eb67ee9ee724c9237cb56273a6a311f0b8151cdeaab8469428", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/469b86d769a0bcf1783e77ce8b31d5ab4ecead015fa44e0e29e54d5c1e407513d55f3049aa20678c5d44b970e3ab7effe901a9d83df426a2ab55f66ea37a6399"} 16:22:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:22:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:22:42 INFO - Contents: 16:22:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c27f4ee0bfcba72a9952c6fd1ca47e9b0667aceea1e9ca2b6ff187be1ea6f0b77f23110cb4256eb67ee9ee724c9237cb56273a6a311f0b8151cdeaab8469428", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/469b86d769a0bcf1783e77ce8b31d5ab4ecead015fa44e0e29e54d5c1e407513d55f3049aa20678c5d44b970e3ab7effe901a9d83df426a2ab55f66ea37a6399"} 16:22:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:42 INFO - Copying logs to upload dir... 16:22:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:22:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.935328 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-22 16:22:42.388792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 16:22:42.390870) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/2c27f4ee0bfcba72a9952c6fd1ca47e9b0667aceea1e9ca2b6ff187be1ea6f0b77f23110cb4256eb67ee9ee724c9237cb56273a6a311f0b8151cdeaab8469428", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/469b86d769a0bcf1783e77ce8b31d5ab4ecead015fa44e0e29e54d5c1e407513d55f3049aa20678c5d44b970e3ab7effe901a9d83df426a2ab55f66ea37a6399"} build_url:https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011058 build_url: 'https://queue.taskcluster.net/v1/task/A1fYtukYTHKQcdLHMMcmHg/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/2c27f4ee0bfcba72a9952c6fd1ca47e9b0667aceea1e9ca2b6ff187be1ea6f0b77f23110cb4256eb67ee9ee724c9237cb56273a6a311f0b8151cdeaab8469428", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/469b86d769a0bcf1783e77ce8b31d5ab4ecead015fa44e0e29e54d5c1e407513d55f3049aa20678c5d44b970e3ab7effe901a9d83df426a2ab55f66ea37a6399"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 16:22:42.435622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:22:42.435936) ========= 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.AAo9QnvX5G/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.Iqizk0bVxy/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005129 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 16:22:42.489368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 16:22:42.491718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 16:22:42.492153) ========= ========= Total master_lag: 0.35 =========