builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0004 starttime: 1459185197.75 results: success (0) buildid: 20160328081427 builduid: 3ef31c12fd9342cf8d700bc0e11cdc0b revision: 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.749821) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.750162) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.750447) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.006003 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.827635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.827929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.988772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:17.989098) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005320 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.044765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.045096) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.045454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.045759) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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-28 10:13:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-03-28 10:13:18 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.610349 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.685497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.685790) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.019420 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:18.733936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 10:13:18.737326) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 --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 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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-28 10:13:18,791 truncating revision to first 12 chars 2016-03-28 10:13:18,791 Setting DEBUG logging. 2016-03-28 10:13:18,791 attempt 1/10 2016-03-28 10:13:18,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/601ab3bdf31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 10:13:19,676 unpacking tar archive at: fx-team-601ab3bdf31c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135830 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 10:13:20.051795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:20.052110) ========= echo 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'601ab3bdf31c3ee85e2183c2ec146164a1f6afa2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 program finished with exit code 0 elapsedTime=0.005134 script_repo_revision: '601ab3bdf31c3ee85e2183c2ec146164a1f6afa2' ========= master_lag: 0.69 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:20.744291) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:20.744593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 10:13:20.928637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-03-28 10:13:20.928908) ========= /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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:13:21 INFO - MultiFileLogger online at 20160328 10:13:21 in /builds/slave/test 10:13:21 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 10:13:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:21 INFO - {'append_to_log': False, 10:13:21 INFO - 'base_work_dir': '/builds/slave/test', 10:13:21 INFO - 'blob_upload_branch': 'Fx-Team', 10:13:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:21 INFO - 'branch': 'Fx-Team', 10:13:21 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:21 INFO - 'config_files': ('talos/mac_config.py',), 10:13:21 INFO - 'default_actions': ('clobber', 10:13:21 INFO - 'read-buildbot-config', 10:13:21 INFO - 'download-and-extract', 10:13:21 INFO - 'populate-webroot', 10:13:21 INFO - 'create-virtualenv', 10:13:21 INFO - 'install', 10:13:21 INFO - 'run-tests'), 10:13:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:21 INFO - 'download_minidump_stackwalk': True, 10:13:21 INFO - 'download_symbols': 'ondemand', 10:13:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:21 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:21 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:21 INFO - 'installer_path': 'installer.exe', 10:13:21 INFO - 'log_level': 'info', 10:13:21 INFO - 'log_name': 'talos', 10:13:21 INFO - 'log_to_console': True, 10:13:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:13:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:13:21 INFO - 'opt_config_files': (), 10:13:21 INFO - 'pip_index': False, 10:13:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:13:21 INFO - 'cmd': ('bash', 10:13:21 INFO - '-c', 10:13:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:13:21 INFO - 'enabled': True, 10:13:21 INFO - 'halt_on_failure': False, 10:13:21 INFO - 'name': 'check_screen_resolution'},), 10:13:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:13:21 INFO - 'cmd': ('bash', 10:13:21 INFO - '-c', 10:13:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:13:21 INFO - 'enabled': True, 10:13:21 INFO - 'halt_on_failure': False, 10:13:21 INFO - 'name': 'check_screen_resolution'},), 10:13:21 INFO - 'run_cmd_checks_enabled': True, 10:13:21 INFO - 'sps_profile': False, 10:13:21 INFO - 'sps_profile_interval': 0, 10:13:21 INFO - 'suite': 'dromaeojs', 10:13:21 INFO - 'system_bits': '32', 10:13:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:21 INFO - 'title': 't-yosemite-r7-0004', 10:13:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:21 INFO - 'use_talos_json': True, 10:13:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:21 INFO - 'work_dir': 'build'} 10:13:21 INFO - ##### 10:13:21 INFO - ##### Running clobber step. 10:13:21 INFO - ##### 10:13:21 INFO - Running pre-action listener: _resource_record_pre_action 10:13:21 INFO - Running main action method: clobber 10:13:21 INFO - rmtree: /builds/slave/test/build 10:13:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:23 INFO - Running post-action listener: _resource_record_post_action 10:13:23 INFO - ##### 10:13:23 INFO - ##### Running read-buildbot-config step. 10:13:23 INFO - ##### 10:13:23 INFO - Running pre-action listener: _resource_record_pre_action 10:13:23 INFO - Running main action method: read_buildbot_config 10:13:23 INFO - Using buildbot properties: 10:13:23 INFO - { 10:13:23 INFO - "project": "", 10:13:23 INFO - "product": "firefox", 10:13:23 INFO - "script_repo_revision": "production", 10:13:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:13:23 INFO - "repository": "", 10:13:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:13:23 INFO - "buildid": "20160328081427", 10:13:23 INFO - "pgo_build": "False", 10:13:23 INFO - "basedir": "/builds/slave/test", 10:13:23 INFO - "buildnumber": 638, 10:13:23 INFO - "slavename": "t-yosemite-r7-0004", 10:13:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:13:23 INFO - "platform": "yosemite_r7", 10:13:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:13:23 INFO - "branch": "fx-team", 10:13:23 INFO - "repo_path": "integration/fx-team", 10:13:23 INFO - "revision": "601ab3bdf31c3ee85e2183c2ec146164a1f6afa2", 10:13:23 INFO - "stage_platform": "macosx64", 10:13:23 INFO - "builduid": "3ef31c12fd9342cf8d700bc0e11cdc0b", 10:13:23 INFO - "slavebuilddir": "test" 10:13:23 INFO - } 10:13:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:13:23 INFO - Running post-action listener: _resource_record_post_action 10:13:23 INFO - ##### 10:13:23 INFO - ##### Running download-and-extract step. 10:13:23 INFO - ##### 10:13:23 INFO - Running pre-action listener: _resource_record_pre_action 10:13:23 INFO - Running main action method: download_and_extract 10:13:23 INFO - mkdir: /builds/slave/test/build/tests 10:13:23 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')]} 10:13:23 INFO - https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:36 INFO - Downloaded 1199 bytes. 10:13:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:13:36 INFO - Using the following test package requirements: 10:13:36 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:13:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:13:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:13:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'jsshell-mac.zip'], 10:13:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:13:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:13:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:13:36 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:13:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:13:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:13:36 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:13:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:36 INFO - https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:38 INFO - Downloaded 17943958 bytes. 10:13:38 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'] 10:13:38 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 10:13:41 INFO - Return code: 0 10:13:41 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 10:13:41 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')]} 10:13:41 INFO - https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:44 INFO - Downloaded 17943958 bytes. 10:13:44 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'] 10:13:44 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 10:13:48 INFO - Return code: 0 10:13: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')]} 10:13:48 INFO - https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:49 INFO - Downloaded 10847531 bytes. 10:13:49 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'] 10:13:49 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 10:13:49 INFO - Return code: 0 10:13:49 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')]} 10:13:49 INFO - https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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 10:13:53 INFO - Downloaded 111378697 bytes. 10:13:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:13:53 INFO - mkdir: /builds/slave/test/properties 10:13:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:53 INFO - Contents: 10:13:53 INFO - build_url:https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:13:54 INFO - Running post-action listener: _resource_record_post_action 10:13:54 INFO - Running post-action listener: set_extra_try_arguments 10:13:54 INFO - ##### 10:13:54 INFO - ##### Running populate-webroot step. 10:13:54 INFO - ##### 10:13:54 INFO - Running pre-action listener: _resource_record_pre_action 10:13:54 INFO - Running main action method: populate_webroot 10:13:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:55 INFO - '--tppagecycles', 10:13:55 INFO - '7'], 10:13:55 INFO - 'tests': ['tsvgm']}}, 10:13:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:13:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:13:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'tests': ['damp', 'tps']}, 10:13:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['damp', 'tps']}, 10:13:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:13:55 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['dromaeo_dom']}, 10:13:55 INFO - 'other': {'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'other_l64': {'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'other_nol64': {'tests': ['a11yr', 10:13:55 INFO - 'ts_paint', 10:13:55 INFO - 'tpaint', 10:13:55 INFO - 'sessionrestore', 10:13:55 INFO - 'sessionrestore_no_auto_restore', 10:13:55 INFO - 'tabpaint']}, 10:13:55 INFO - 'svgr': {'tests': ['tsvgx', 10:13:55 INFO - 'tsvgr_opacity', 10:13:55 INFO - 'tart', 10:13:55 INFO - 'tscrollx', 10:13:55 INFO - 'cart']}, 10:13:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['tsvgx', 10:13:55 INFO - 'tsvgr_opacity', 10:13:55 INFO - 'tart', 10:13:55 INFO - 'tscrollx', 10:13:55 INFO - 'cart']}, 10:13:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'tests': ['tp5o']}, 10:13:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'talos_options': ['--e10s'], 10:13:55 INFO - 'tests': ['tp5o']}, 10:13:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'talos_options': ['--xperf_path', 10:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:55 INFO - 'tests': ['tp5n']}, 10:13:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:55 INFO - 'talos_options': ['--e10s', 10:13:55 INFO - '--xperf_path', 10:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:55 INFO - 'tests': ['tp5n']}}, 10:13:55 INFO - 'talos.zip': {'path': '', 10:13:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:55 INFO - Running post-action listener: _resource_record_post_action 10:13:55 INFO - ##### 10:13:55 INFO - ##### Running create-virtualenv step. 10:13:55 INFO - ##### 10:13:55 INFO - Running pre-action listener: _resource_record_pre_action 10:13:55 INFO - Running main action method: create_virtualenv 10:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:55 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 10:13:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:55 INFO - Using real prefix '/tools/python27' 10:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:58 INFO - Installing pip.................done. 10:13:58 INFO - Return code: 0 10:13:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:13: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 10:13: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 10:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:58 INFO - 'HOME': '/Users/cltbld', 10:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:58 INFO - 'LOGNAME': 'cltbld', 10:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:58 INFO - 'MOZ_NO_REMOTE': '1', 10:13:58 INFO - 'NO_EM_RESTART': '1', 10:13:58 INFO - 'PAGER': '/bin/cat', 10:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:58 INFO - 'PWD': '/builds/slave/test', 10:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:58 INFO - 'SHELL': '/bin/bash', 10:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:13:58 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:58 INFO - 'USER': 'cltbld', 10:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:58 INFO - 'XPC_FLAGS': '0x0', 10:13:58 INFO - 'XPC_SERVICE_NAME': '0', 10:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13: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 10:13:58 INFO - Cleaning up... 10:13:58 INFO - Return code: 0 10:13:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:13: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')]} 10:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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')]} 10:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:13: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 10:13: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 10:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:58 INFO - 'HOME': '/Users/cltbld', 10:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:58 INFO - 'LOGNAME': 'cltbld', 10:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:58 INFO - 'MOZ_NO_REMOTE': '1', 10:13:58 INFO - 'NO_EM_RESTART': '1', 10:13:58 INFO - 'PAGER': '/bin/cat', 10:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:58 INFO - 'PWD': '/builds/slave/test', 10:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:58 INFO - 'SHELL': '/bin/bash', 10:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:13:58 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:58 INFO - 'USER': 'cltbld', 10:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:58 INFO - 'XPC_FLAGS': '0x0', 10:13:58 INFO - 'XPC_SERVICE_NAME': '0', 10:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:59 INFO - Downloading/unpacking psutil>=0.7.1 10:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:02 INFO - Installing collected packages: psutil 10:14:02 INFO - Running setup.py install for psutil 10:14:02 INFO - building 'psutil._psutil_osx' extension 10:14: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:14: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 10:14: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 10:14: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 10:14:02 INFO - building 'psutil._psutil_posix' extension 10:14: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 10:14:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:14:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:14:02 INFO - ^ 10:14:02 INFO - 1 warning generated. 10:14: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 10:14:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:03 INFO - Successfully installed psutil 10:14:03 INFO - Cleaning up... 10:14:03 INFO - Return code: 0 10:14:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:03 INFO - 'HOME': '/Users/cltbld', 10:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:03 INFO - 'LOGNAME': 'cltbld', 10:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:03 INFO - 'MOZ_NO_REMOTE': '1', 10:14:03 INFO - 'NO_EM_RESTART': '1', 10:14:03 INFO - 'PAGER': '/bin/cat', 10:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:03 INFO - 'PWD': '/builds/slave/test', 10:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:03 INFO - 'SHELL': '/bin/bash', 10:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:03 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:03 INFO - 'USER': 'cltbld', 10:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:03 INFO - 'XPC_FLAGS': '0x0', 10:14:03 INFO - 'XPC_SERVICE_NAME': '0', 10:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:14:06 INFO - Installing collected packages: mozsystemmonitor 10:14:06 INFO - Running setup.py install for mozsystemmonitor 10:14:06 INFO - Successfully installed mozsystemmonitor 10:14:06 INFO - Cleaning up... 10:14:06 INFO - Return code: 0 10:14:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:06 INFO - 'HOME': '/Users/cltbld', 10:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:06 INFO - 'LOGNAME': 'cltbld', 10:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:06 INFO - 'MOZ_NO_REMOTE': '1', 10:14:06 INFO - 'NO_EM_RESTART': '1', 10:14:06 INFO - 'PAGER': '/bin/cat', 10:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:06 INFO - 'PWD': '/builds/slave/test', 10:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:06 INFO - 'SHELL': '/bin/bash', 10:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:06 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:06 INFO - 'USER': 'cltbld', 10:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:06 INFO - 'XPC_FLAGS': '0x0', 10:14:06 INFO - 'XPC_SERVICE_NAME': '0', 10:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:10 INFO - Downloading docopt-0.6.1.tar.gz 10:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:10 INFO - Running setup.py install for blobuploader 10:14:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:10 INFO - Running setup.py install for requests 10:14:11 INFO - Running setup.py install for docopt 10:14:11 INFO - Successfully installed blobuploader requests docopt 10:14:11 INFO - Cleaning up... 10:14:11 INFO - Return code: 0 10:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:11 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')]} 10:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 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')]} 10:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:11 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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14:11 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 10:14:11 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 10:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:11 INFO - 'HOME': '/Users/cltbld', 10:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:11 INFO - 'LOGNAME': 'cltbld', 10:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:11 INFO - 'MOZ_NO_REMOTE': '1', 10:14:11 INFO - 'NO_EM_RESTART': '1', 10:14:11 INFO - 'PAGER': '/bin/cat', 10:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:11 INFO - 'PWD': '/builds/slave/test', 10:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:11 INFO - 'SHELL': '/bin/bash', 10:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:11 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:11 INFO - 'USER': 'cltbld', 10:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:11 INFO - 'XPC_FLAGS': '0x0', 10:14:11 INFO - 'XPC_SERVICE_NAME': '0', 10:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-oN5I5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-uyu642-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Ap0wGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:11 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-blLdUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-5DuPmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-W35l9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-hhiLpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-_gblHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-f30bCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-x1McfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-zyNKeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-kbLxfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-qYqbZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:12 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Vk0lSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:13 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-iRvR7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:13 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-n4_Cky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:13 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-1IzTPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:13 INFO - Running setup.py install for manifestparser 10:14:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:13 INFO - Running setup.py install for mozcrash 10:14:13 INFO - Running setup.py install for mozdebug 10:14:13 INFO - Running setup.py install for mozdevice 10:14:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:13 INFO - Running setup.py install for mozfile 10:14:14 INFO - Running setup.py install for mozhttpd 10:14:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Running setup.py install for mozinfo 10:14:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Running setup.py install for mozInstall 10:14:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Running setup.py install for mozleak 10:14:14 INFO - Running setup.py install for mozlog 10:14:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:14 INFO - Running setup.py install for moznetwork 10:14:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Running setup.py install for mozprocess 10:14:15 INFO - Running setup.py install for mozprofile 10:14:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Running setup.py install for mozrunner 10:14:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Running setup.py install for mozscreenshot 10:14:15 INFO - Running setup.py install for moztest 10:14:15 INFO - Running setup.py install for mozversion 10:14:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:15 INFO - Cleaning up... 10:14:15 INFO - Return code: 0 10:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:15 INFO - 'HOME': '/Users/cltbld', 10:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:15 INFO - 'LOGNAME': 'cltbld', 10:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:15 INFO - 'MOZ_NO_REMOTE': '1', 10:14:15 INFO - 'NO_EM_RESTART': '1', 10:14:15 INFO - 'PAGER': '/bin/cat', 10:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:15 INFO - 'PWD': '/builds/slave/test', 10:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:15 INFO - 'SHELL': '/bin/bash', 10:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:15 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:15 INFO - 'USER': 'cltbld', 10:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:15 INFO - 'XPC_FLAGS': '0x0', 10:14:15 INFO - 'XPC_SERVICE_NAME': '0', 10:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-nYMUw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:16 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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-M_L6oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-QaeDPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-93d93x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-qJ5J8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-On3UEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-lsMOCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14: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)) 10:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:16 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Lj171S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:17 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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-VijcDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:17 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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-Iw1QrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:17 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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-51JDuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:17 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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-iuKLKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14: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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-oYmyRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14: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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-dq0LKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14: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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-aBEyZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14: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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-7ktGHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14: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)) 10:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:17 INFO - Running setup.py (path:/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/pip-iSaxeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:18 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)) 10:14:18 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)) 10:14:18 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)) 10:14:18 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)) 10:14:18 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)) 10:14:18 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)) 10:14:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:20 INFO - Downloading blessings-1.6.tar.gz 10:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:20 INFO - Installing collected packages: blessings 10:14:20 INFO - Running setup.py install for blessings 10:14:20 INFO - Successfully installed blessings 10:14:20 INFO - Cleaning up... 10:14:20 INFO - Return code: 0 10:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:21 INFO - Reading from file tmpfile_stdout 10:14:21 INFO - Current package versions: 10:14:21 INFO - blessings == 1.6 10:14:21 INFO - blobuploader == 1.2.4 10:14:21 INFO - docopt == 0.6.1 10:14:21 INFO - manifestparser == 1.1 10:14:21 INFO - mozInstall == 1.12 10:14:21 INFO - mozcrash == 0.17 10:14:21 INFO - mozdebug == 0.1 10:14:21 INFO - mozdevice == 0.48 10:14:21 INFO - mozfile == 1.2 10:14:21 INFO - mozhttpd == 0.7 10:14:21 INFO - mozinfo == 0.9 10:14:21 INFO - mozleak == 0.1 10:14:21 INFO - mozlog == 3.1 10:14:21 INFO - moznetwork == 0.27 10:14:21 INFO - mozprocess == 0.22 10:14:21 INFO - mozprofile == 0.28 10:14:21 INFO - mozrunner == 6.11 10:14:21 INFO - mozscreenshot == 0.1 10:14:21 INFO - mozsystemmonitor == 0.0 10:14:21 INFO - moztest == 0.7 10:14:21 INFO - mozversion == 1.4 10:14:21 INFO - psutil == 3.1.1 10:14:21 INFO - requests == 1.2.3 10:14:21 INFO - wsgiref == 0.1.2 10:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:21 INFO - 'HOME': '/Users/cltbld', 10:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:21 INFO - 'LOGNAME': 'cltbld', 10:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:21 INFO - 'MOZ_NO_REMOTE': '1', 10:14:21 INFO - 'NO_EM_RESTART': '1', 10:14:21 INFO - 'PAGER': '/bin/cat', 10:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:21 INFO - 'PWD': '/builds/slave/test', 10:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:21 INFO - 'SHELL': '/bin/bash', 10:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:21 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:21 INFO - 'USER': 'cltbld', 10:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:21 INFO - 'XPC_FLAGS': '0x0', 10:14:21 INFO - 'XPC_SERVICE_NAME': '0', 10:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14: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)) 10:14:21 INFO - Cleaning up... 10:14:21 INFO - Return code: 0 10:14:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:21 INFO - 'HOME': '/Users/cltbld', 10:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:21 INFO - 'LOGNAME': 'cltbld', 10:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:21 INFO - 'MOZ_NO_REMOTE': '1', 10:14:21 INFO - 'NO_EM_RESTART': '1', 10:14:21 INFO - 'PAGER': '/bin/cat', 10:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:21 INFO - 'PWD': '/builds/slave/test', 10:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:21 INFO - 'SHELL': '/bin/bash', 10:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:21 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:21 INFO - 'USER': 'cltbld', 10:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:21 INFO - 'XPC_FLAGS': '0x0', 10:14:21 INFO - 'XPC_SERVICE_NAME': '0', 10:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:21 INFO - Downloading/unpacking jsonschema 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:24 INFO - Downloading/unpacking functools32 (from jsonschema) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:24 INFO - warning: no files found matching '*.txt' 10:14:24 INFO - no previously-included directories found matching 'build' 10:14:24 INFO - no previously-included directories found matching 'dist' 10:14:24 INFO - no previously-included directories found matching '.git*' 10:14:24 INFO - Installing collected packages: jsonschema, functools32 10:14:24 INFO - Running setup.py install for functools32 10:14:24 INFO - warning: no files found matching '*.txt' 10:14:24 INFO - no previously-included directories found matching 'build' 10:14:24 INFO - no previously-included directories found matching 'dist' 10:14:24 INFO - no previously-included directories found matching '.git*' 10:14:24 INFO - Successfully installed jsonschema functools32 10:14:24 INFO - Cleaning up... 10:14:24 INFO - Return code: 0 10:14:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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 0x102deba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102dfb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb3a48c880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, '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.pPViYfdvEU/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.skpaUYTGEF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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 10:14: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 10:14: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 10:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:25 INFO - 'HOME': '/Users/cltbld', 10:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:25 INFO - 'LOGNAME': 'cltbld', 10:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:25 INFO - 'MOZ_NO_REMOTE': '1', 10:14:25 INFO - 'NO_EM_RESTART': '1', 10:14:25 INFO - 'PAGER': '/bin/cat', 10:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:25 INFO - 'PWD': '/builds/slave/test', 10:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:25 INFO - 'SHELL': '/bin/bash', 10:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:14:25 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:25 INFO - 'USER': 'cltbld', 10:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:25 INFO - 'XPC_FLAGS': '0x0', 10:14:25 INFO - 'XPC_SERVICE_NAME': '0', 10:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:25 INFO - Downloading/unpacking flake8 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:30 INFO - no previously-included directories found matching 'docs/_build' 10:14:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:30 INFO - Running setup.py install for pep8 10:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:30 INFO - no previously-included directories found matching 'docs/_build' 10:14:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:14:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:30 INFO - Cleaning up... 10:14:30 INFO - Return code: 0 10:14:30 INFO - Running post-action listener: _resource_record_post_action 10:14:30 INFO - Running post-action listener: _start_resource_monitoring 10:14:30 INFO - Starting resource monitoring. 10:14:30 INFO - ##### 10:14:30 INFO - ##### Running install step. 10:14:30 INFO - ##### 10:14:30 INFO - Running pre-action listener: _resource_record_pre_action 10:14:30 INFO - Running main action method: install 10:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:30 INFO - Reading from file tmpfile_stdout 10:14:30 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:30 INFO - Reading from file tmpfile_stdout 10:14:30 INFO - Output received: 10:14:30 INFO - Usage: mozinstall [options] installer 10:14:30 INFO - Options: 10:14:30 INFO - -h, --help show this help message and exit 10:14:30 INFO - -d DEST, --destination=DEST 10:14:30 INFO - Directory to install application into. [default: 10:14:30 INFO - "/builds/slave/test"] 10:14:30 INFO - --app=APP Application being installed. [default: firefox] 10:14:30 INFO - mkdir: /builds/slave/test/build/application 10:14: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'] 10:14: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 10:15:04 INFO - Reading from file tmpfile_stdout 10:15:04 INFO - Output received: 10:15:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:15:04 INFO - Running post-action listener: _resource_record_post_action 10:15:04 INFO - ##### 10:15:04 INFO - ##### Running run-tests step. 10:15:04 INFO - ##### 10:15:04 INFO - Running pre-action listener: _resource_record_pre_action 10:15:04 INFO - Running main action method: run_tests 10:15:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:15:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:15:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:15:04 INFO - 2016-03-28 10:15:04.665 screenresolution[2493:22325] starting screenresolution argv=screenresolution get 10:15:04 INFO - 2016-03-28 10:15:04.667 screenresolution[2493:22325] Display 0: 1600x1200x32@60 10:15:04 INFO - 2016-03-28 10:15:04.673 screenresolution[2494:22327] starting screenresolution argv=screenresolution list 10:15:04 INFO - Available Modes on Display 0 10:15:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:15:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:15:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:15:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:15:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:15:04 INFO - Intel Iris: 10:15:04 INFO - Chipset Model: Intel Iris 10:15:04 INFO - Type: GPU 10:15:04 INFO - Bus: Built-In 10:15:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:15:04 INFO - Vendor: Intel (0x8086) 10:15:04 INFO - Device ID: 0x0a2e 10:15:04 INFO - Revision ID: 0x0009 10:15:04 INFO - Displays: 10:15:04 INFO - Display: 10:15:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:15:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:15:04 INFO - Display Serial Number: 1600x1200 60 10:15:04 INFO - Main Display: Yes 10:15:04 INFO - Mirror: Off 10:15:04 INFO - Online: Yes 10:15:04 INFO - Rotation: Supported 10:15:04 INFO - Return code: 0 10:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:04 INFO - Python 2.7.3 10:15:04 INFO - Return code: 0 10:15:04 INFO - grabbing minidump binary from tooltool 10:15: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')]} 10:15: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 0x102c8ae00>, '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 0x102ab3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c85b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15: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 10:15: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 10:15:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:04 INFO - Return code: 0 10:15:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:15:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:15:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:15:06 INFO - Return code: 0 10:15: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/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 10:15: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/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0004 --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 10:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pPViYfdvEU/Render', 10:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:15:06 INFO - 'HOME': '/Users/cltbld', 10:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:15:06 INFO - 'LOGNAME': 'cltbld', 10:15:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:06 INFO - 'MOZ_NO_REMOTE': '1', 10:15:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:06 INFO - 'NO_EM_RESTART': '1', 10:15:06 INFO - 'PAGER': '/bin/cat', 10:15:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:06 INFO - 'PWD': '/builds/slave/test', 10:15:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:15:06 INFO - 'SHELL': '/bin/bash', 10:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.skpaUYTGEF/Listeners', 10:15:06 INFO - 'TMPDIR': '/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/', 10:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:15:06 INFO - 'USER': 'cltbld', 10:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:06 INFO - 'XPC_FLAGS': '0x0', 10:15:06 INFO - 'XPC_SERVICE_NAME': '0', 10:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:15: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/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 10:15:06 INFO - mozversion application_buildid: 20160328081427 10:15:06 INFO - mozversion application_changeset: 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 10:15:06 INFO - mozversion application_display_name: Nightly 10:15:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:06 INFO - mozversion application_name: Firefox 10:15:06 INFO - mozversion application_remotingname: firefox 10:15:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:15:06 INFO - mozversion application_vendor: Mozilla 10:15:06 INFO - mozversion application_version: 48.0a1 10:15:06 INFO - mozversion platform_buildid: 20160328081427 10:15:06 INFO - mozversion platform_changeset: 601ab3bdf31c3ee85e2183c2ec146164a1f6afa2 10:15:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:15:06 INFO - mozversion platform_version: 48.0a1 10:15:06 INFO - using testdate: 1459185306 10:15:06 INFO - actual date: 1459185306 10:15:06 INFO - starting webserver on 'localhost:57680' 10:15:06 INFO - SUITE-START | Running 2 tests 10:15:06 INFO - TEST-START | dromaeo_css 10:15:06 INFO - operating with platform_type : mac_ 10:15:06 INFO - Initialising browser for dromaeo_css test... 10:15:06 INFO - TEST-INFO | started process 2512 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpsTInxY/profile http://localhost:57680/getInfo.html) 10:15:08 INFO - PROCESS | 2512 | __metrics Screen width/height:1600/1200 10:15:08 INFO - PROCESS | 2512 | colorDepth:24 10:15:08 INFO - PROCESS | 2512 | Browser inner width/height: 1024/689 10:15:08 INFO - PROCESS | 2512 | __metrics 10:15:08 INFO - PROCESS | 2512 | 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" 10:15:08 ERROR - PROCESS | 2512 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:15:09 INFO - TEST-INFO | 2512: exit 0 10:15:09 INFO - Browser initialized. 10:15:09 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:09 INFO - TEST-INFO | started process 2515 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmpsTInxY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:21 INFO - PROCESS | 2515 | RSS: Main: 244314112 10:15:21 INFO - PROCESS | 2515 | 10:16:12 INFO - PROCESS | 2515 | 1459185372380 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] 10:18:21 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57680/tests/dromaeo/cssquery-ext.html) 10:18:23 INFO - PROCESS | 2515 | RSS: Main: 423268352 10:18:23 INFO - PROCESS | 2515 | 10:21:26 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-ext.html (next: http://localhost:57680/tests/dromaeo/cssquery-jquery.html) 10:21:27 INFO - PROCESS | 2515 | RSS: Main: 379305984 10:21:27 INFO - PROCESS | 2515 | 10:24:29 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57680/tests/dromaeo/cssquery-mootools.html) 10:24:29 INFO - PROCESS | 2515 | RSS: Main: 378265600 10:24:29 INFO - PROCESS | 2515 | 10:27:31 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57680/tests/dromaeo/cssquery-prototype.html) 10:27:32 INFO - PROCESS | 2515 | RSS: Main: 335888384 10:27:32 INFO - PROCESS | 2515 | 10:30:35 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57680/tests/dromaeo/cssquery-yui.html) 10:30:35 INFO - PROCESS | 2515 | RSS: Main: 338526208 10:30:35 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:57680/tests/dromaeo/cssquery-yui.html (next: http://localhost:57680/tests/dromaeo/cssquery-dojo.html) 10:33:38 INFO - PROCESS | 2515 | RSS: Main: 410009600 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | __start_tp_report 10:33:38 INFO - PROCESS | 2515 | _x_x_mozilla_page_load 10:33:38 INFO - PROCESS | 2515 | _x_x_mozilla_page_load_details 10:33:38 INFO - PROCESS | 2515 | |i|pagename|runs| 10:33:38 INFO - PROCESS | 2515 | |0;dojo.html;3297.868085276589;3373.156710822293;3404.727621790257;3411.8805841795534;3442.3631628148796;5422.647527910693;5480.561555075595;5488.121900495921;5490.725463726818;5531.944680553198;5482;5519.613627046108;5538.335399752025;5664.291963504562;5667.376588575254;4987.351644286237;5000.749962501878;5028.446870844205;5056.721880296583;5192.688438693691;5112.437631860493;5119.411267704225;5139.100657384962;5147.691138531682;5152.562032227265;4974.527419895104;4992.775325110379;5076.619253555979;5080.79676812927;5121.871953201163;5062.341895553554;5065.316182315414;5072.036313100499;5079.466656001141;5117.795288188505;5002.549770520634;5056.115179843549;5062.594992400599;5063.873403164914;5087.516685914832;5319.3616765987945;5395.10980688186;5406.486383793534;5421.620486565942;5519.503244707956;5983.1623572699855;5997.460228579405;6003.759849606055;6012.518998480111;6017.127516510125;6038.939610603926;6098.1157732128595;6107.4197951194565;6120.990036643949;6124.11200375943;5499.312585926759;5571.9721401392735;5603.60774745768;5658.405867383948;5685.800996965087;6178.011518157163;6197.070439434031;6202.503799696014;6204.875902481925;6214.844628884314;4805.711657300573;5789.478946894799;5853.795117170878;5866.882662346729;5925.081612350093;5904.7342869570975;5992.940070599326;5997.670128142907;6057.151998720183;6095.6952152392205;5957.106434034929;5962.135490353874;5967.701614919237;5978.372270911578;5993.101034844721;6009.549283803733;6017.097435384728;6025.3372129065765;6034.969825150846;6035.909461358083;4685.461171965268;4704.341392205094;4764.190087685102;4770.737609431515;4779.450363208206;4256.787160641956;4290.420793192879;4333.241682705514;4353.804078816461;4376.518582955872;5408.161734931092;5415.323084614423;5449.455054494519;5457.672539647634;5504.284443022381;5879.323877754027;6018.668973206516;6051.031834906482;6060.636361818217;6074.908876366858;5373.919391209135;5381.434949330264;5439.428859969726;5479.958807826501;5481.314835645544;5153.098207813618;5164.948350516522;5181.145111056633;5184.844454666366;5215.217717342429;6141.907871382022;6208.534359923024;6231.065340199007;6269.310375858743;6278.0269058296035;5915.852103697442;5978.970105149447;6047.516198704006;6072.939270607414;6091.269047714125;6208.81373558794;6224.06639004153;6264.373562643699;6278.780242691484;6302.747890084345;5783.334916484658;5904.704764761831;5909.970450147722;5916.26046744157;5975.581709280309;5951.166836642787;5959.135925290895;6002.819915402545;6075.848103797441;6094.573379863367;5763.682997435181;5768.423157684198;5770.163326317745;5781.79763708285;5784.82645520635;5704.1443783432815;5781;5800.76796928135;5815.5929084963645;5826.41735826414;5669.036263835241;5684.033714268501;5684.289463817023;5685.431456854447;5710.2576665033275;5766.3368712598585;5844.503217226584;5853.03424934881;5885.411458854252;5889.38161493037;5753.252077229933;5762.769489220552;5770.336411312753;5770.682612456355;5784.681842498535 10:33:38 INFO - PROCESS | 2515 | |1;ext.html;469.87465021274073;522.2401405954337;576.0552693582525;609.734765377061;639.3159319528107;29420.264493387676;37948.62051379486;38394.04014899625;38435.846924592304;38480.615193848054;41753.79123104388;41940.37089443653;42113.36829947553;42140;42323.3651495227;9423.481708506013;9658.661946831862;9666.806663866719;9667.5649595768;9691.321607487478;9503.714888553355;9643.566039528203;9661.903380966205;9674.564644590975;9782.9510852446;9712.514374281292;9790.608375664964;9809.705708828747;9821.607135714563;9822.852657210147;9685.90314096857;9784.364016338986;9787.217022638242;9792.853107203398;9793.020697930186;9638.325317227796;9686.70939871805;9691.806163876754;9706.90293097074;9777.217822574177;39432.60567394318;39475.407868881986;39493.60506394928;39996.60003399958;40293.79118626446;2811.3955499567487;3241.2059045533997;3392.6607339266125;3598.226381328027;3804.4673745675627;28670.856645716845;28967;29275.41449171026;29309.413811723858;29360.56829486552;2719.8504082275467;2744.2727677165567;2754.614353990443;2765.3224959884956;2891.3783536539745;384001;384616;385087.9999999972;385510;385876;45734;67364.6631766838;67951;67991;68249.31750682529;45314;45509.54490455119;45543.316850247276;45675.54324456713;45794;15484.690306193814;15832.76250856238;15863.286152123183;15877.364905403654;15882.92058539723;12756.80864787029;12807.295598741972;12819.935900320439;12842.48630054806;12870.905972992401;12214;12610.495580176874;14448.494302699355;14477.276136193148;14701.852981470049;5421.539169170585;5493.423190565013;6132.724027418777;6327.475854763774;6429.553350496194;976.6532880827347;980.7499087732582;1023.6212601337404;1064.2018486135398;1094.9835752463719;21181.470463238544;23593.05627774904;29736.55395169074;29793.85103074514;29935.103010306244;997.870276864003;1052.8526006358964;1104.4588151805558;1111.8054340490382;1148.3970915269383;14327.641808954859;14845.886558508155;14862.182579958206;15067;15170;549599.5040049629;552635;556028;561005;561257;59237;59769;59781;59798.70100649556;60027;1342.4026308292716;1447.1317209674112;1454.905431146972;1476.837547869712;1496.9850301497063;28105.578416323362;28116.71883281141;28761.712382875903;28881;29030.564541532316;41594.58405416028;45857.77071114623;46770.29844552402;46844;46965.53034469612;328106;330155;330495.6950430561;330544.3472782621;331181;28554.286142846595;32587.837060814545;33149.83975560844;33564.99305020853;33810.661893380755;41702.1659566813;42745.572544275405;44157.33763993607;44301.55698443103;45782;35313.82343088268;36408.63591364052;36825.26349473049;37206.88379348624;37233.44149837809;35825.64174358223;36139.27721445609;36200.456993144595;36830.63169368272;36895;36353.63646363608;36488.27023459569;37040.6295937048;37390.439143413416;37511;28261.434771304048;30132.69867301299;32114.03657890267;32183;32488.187795304362;24167.352332510112;24306.27081187567;24460.388490287885;24606.13878514315;24830.627540587266 10:33:38 INFO - PROCESS | 2515 | |2;jquery.html;358.7542533364645;362.76057801850783;362.97640653357524;371.2982463144657;375.38436963380076;19815.60368792625;20576.69134962975;20632.1747130115;20798.792012079874;21146.836923969175;19633.410997670093;19695.21219151232;20430.182792688312;20450.284240051602;20629;5593.52455041321;5746.712664366765;5804.477597016267;5809.070548712207;5815.098659707752;4161.25097482453;4345.760983145926;5765.336986246593;6472.482201423898;6472.644004579746;6201.658908760039;6357.427831495164;6361.968190159043;6379.968100159493;6388.425041746242;6023.277206735198;6331.163962450883;6451.903221451682;6454.6449945253225;6478.578892371981;5560.638558493725;5567.359753628303;5580.665160090408;5581.944180558183;5585.804496842591;21246.468838279012;25566;25930.573818439978;26167.607485887725;26358.341041473926;2110.2719561751323;2139.6469582518866;2195.5718634866207;2196.2752291743686;2274.6701728249477;14723;14739.96820222585;14825.258737063104;15129.924350378178;15333.693326133527;1420.8721215090588;1703.4548944337816;1722.4488163787594;1748.8338607832236;1822.589917268604;98831;99830;102486.9751302485;102546.48726756393;103327;10004.699859004242;10397.11624511925;10436.63471778484;10459;10531.104856087166;12751.936240318739;12863.614091577268;12875.678108047186;12898.226106433456;12912.998485234804;8410.49537027768;8591.6992905248;8613.526256055851;8703.86944195825;8704.738857834274;8048.993875765529;8869.955650221707;8883.689070882618;8907.064758200426;8975.730728078037;5535.33575970878;6028.196888446893;6028.367021462684;6035.758569657164;6131.877362452726;1732.229158024667;1768.32803534656;1774.97337539937;1778.5286898971783;1787.4012205911165;914.7210100919284;961.8124465729255;977.6089564174387;1026.8665073540392;1047.4291511126455;20371.981400929893;20567.38297851067;20951.58096838085;21012.789872101388;21312.467188320104;839.9706010289733;967.670991862756;972.1736523954723;1041.4063983529315;1090.8690957085041;10228.284020118668;11048.889511104786;11362;11386.316820990767;11426.028787552985;248017.75991120288;248391.75804120864;326990;515479;658942;102998;103017;105482;105681;106261.46869265758;1035.1615191694752;1040.0587468341164;1055.256044488649;1057.043375744952;1059.5655781129853;18238;18465;18558.536036598653;18560;18973.810261897204;36616.81691591525;46797.53202467932;47240.05519889514;47245.527544724115;47812.56562303136;62965.68517157385;63148.36851631425;64054.03918941126;64221;64291.67854160699;7686.077670679554;7762.41781866351;7775;7801.1808760079375;8087.514749115072;12291.631251062483;12835.42240599194;12844.807327890276;12845.486180552673;13104.017198710326;9833.213342932691;10886.67339979802;11252.493637786483;11409.657710268706;11528.250663706833;10794.244402891722;10814.405207713651;11049.226554141133;11053.834192486958;11290.266132701348;11328.490217940047;11467.655970320904;11470.311781293149;11630.592929247436;11638.185327027028;7617.200193979774;7656.425768067305;7772.417068719756;7814.53112813233;8012;11154.888451115385;11186.664400068012;11500.137489688474;11542.365169915734;11588.420578971187 10:33:38 INFO - PROCESS | 2515 | |3;mootools.html;1416.2564653556888;1551.612096975756;1631.0784406810155;1914.186470749932;2053.6200802851463;8026.598670066495;8738.694145704902;8936.776580585496;8939.86590201146;8940.59767310471;8537.2743316818;8653.134686531359;8680.522571258594;8683.43557668751;8858.911410885888;2183.836212284077;2420.782129608335;2473.690788651423;2498.537770512452;2502.099244272061;2088.363049269972;2510.8242423030397;2515.6981162260463;2519.143491212987;2522.1676846640657;2058.547119633678;2420.068273714615;2450.546648869965;2451.7180524239675;2471.925842224727;2423.6970378702663;2463.987680061606;2469.6789417375717;2471.9134830280946;2485.7389974052644;2418.322869596516;2465.3466831289725;2482.7020757509035;2486.8632225227607;2487.2911220302126;8893.4663920165;8993.415427997159;9002.639894404216;9003.00966893641;9026.684066057656;5487.725613719338;5505.146702261156;5566;5667.603267771257;5679.318481782171;2982.9850850745606;3636.690881275095;3693.2244228712;3699.963000370016;3745.3632882410056;1048.905598496139;1065.339489516497;1065.8294672852385;1076.4187338837019;1080.0387654987069;11036.944815275952;11448.141389395829;12130.272183669009;12191.085668574893;12238.81641775374;4894.094592500399;4894.486078961729;4931.038447502774;4943.110240156806;4962.826301079445;8650;10236.33463824864;10236.846447303296;10242.487875606339;10285.22860785444;5542.695151766691;5564.693941833238;5580.051391263495;5586.1062230043;5590.888182236333;4465.106978604292;4614.307853821886;4950.381202349707;5051.1413059779925;5059.569936555434;3865.9226815464094;3916.7258291919293;3932.8623498177426;3958.089639382958;3973.6026397360033;1301.3753398368835;1314.664760486089;1320.5972178485654;1330.8772507850158;1331.8801307882336;1346.4344975110478;1364.283751030697;1383.6955869708647;1406.7678832992442;1415.7876318552094;8463.534505602127;8536.8719469208;8569.957150214334;8571.314294856396;8577.785555361166;526.4393421006615;526.5287567626953;530.374158492982;532.1060618161448;535.9517643412112;6341.175647165931;6346.777862774781;6398.488120950313;6405.423511883952;6424.807255782334;10725.51735171919;10998.615048473264;11133.832992505118;11147;11158.497867595977;10718.839217411745;10806.405647689295;10871.184661150288;10944.726381840517;10990.560377584807;8495.405321627426;8533.615987280464;8574.185452382013;8611.61247743853;8643.654253829776;7994.1606131355375;8112.351011919151;8135.593220339078;8175.959120204361;8198.057223419382;9348.579313930753;9543;9773;9814.362066465657;9933.255005874733;9871.851922221316;10063.194944404284;10177.847332289874;10245.180385569285;10253;7691.50005249657;7693.807654808675;7724.497907635986;7786.7663970080985;7809.843803123792;8445.535495547803;8464.66141354339;8520.318374530147;8521.573921304034;8558.101399352978;6577.914644083673;7462.813429664302;7657.425693072931;7749.108852482037;7762.301392874669;6524.412802847766;7439.181690014202;7502.549847009197;7504.924950750423;7638.694452222071;7984.281414672707;8004.079530854026;8019.9198008019175;8026.077001144943;8075.030996280484;6028.728707208274;6865.176178858369;7125.394341480825;7204;7258.89111663336;7202.027726256888;7224.13310402755;7254.89117663246;7255.455840811855;7268.454865884974 10:33:38 INFO - PROCESS | 2515 | |4;prototype.html;288.2361741385329;329.364326849181;329.96700329967007;334.785737128238;336.6582918337886;5339.439358867321;5805.680687562182;6428.19647544057;6490.513211509144;6511.902321465182;6342.334054924236;6417.679116044203;6502.7398904043785;6516.218053833535;6540.4440622547145;3521.894343169696;4286.699931004831;4759.809607615691;4891.241857512083;4893.8042478301;4785.401824771903;4822.132016237076;4826.975865120669;4838.951610483885;4858.0283943211325;4718.693284936486;4729.6452766042685;4773.18855794514;4779.928301075487;4783.928241076386;4255.723377980421;4392.901774556345;4696.929546056812;4824.348712923746;4869.853904382874;3778.9796754876306;4033.3949907513816;4109.6506796922295;4135.875923722293;4151.6886233532605;6106.114613381079;6210.285817131043;6229.345918678564;6236.251649802008;6270.7805226816845;4674.228752255874;5676.1769543416385;5686.118651608966;5699.404166833293;5707.429257074301;6293.9370606293805;6923.723051077951;6935.514513984023;6937.993990871295;6956.165260168812;3842.346801043829;4510.413646226002;4681.368015317923;4695.319178719101;4700.130475861943;5753.597248192628;7198.892016619755;7268.328284494596;7366;7372.115346158495;4788.856334309976;4797.928031079537;4800.687955282895;4803.0153818467825;4803.543663351976;4852.854414367504;4861.149298872683;4862.78117484714;4873.342098816685;4876.804927802848;4211.947013246689;4949.430815456197;5474.91787623186;5761;5772.538196944234;6794.939481042658;6903.309669033157;6977.33715297046;7012.826023932597;7034.6482675866;1247.8440194975628;1666.491720025404;1690.636513149654;1693.424235759823;1696.8303169682933;1031.1235449867552;1087.6628245243999;1090.7491277006334;1105.077260487502;1108.5953626926114;5394.056040192951;6179.258488981351;6362.1093046973465;6530.542861999615;6554.442872355808;7247;7275.017872587239;7284.6721897514735;7287.380572651384;7298.087739032621;6477;6494.4479719223455;6511.967440162769;6512.381323774234;6513.413792758674;3438.570178727659;3797.5632802227547;3843.9237013636225;3853.190829925747;3855.614438556178;6702.832429189211;7601.707709689366;7637.3579680368985;7666.501677390952;7677.385809135256;7460.813479663052;7515.023047003964;7523.247675232543;7532.983047288546;7543.547387156788;7616.314531692175;7627.504212226077;7628.351590114791;7631;7636.236376362319;6986.266442023514;7244.4566657501955;7246.1666908306215;7260.165081015751;7262.491625586158;5236.947630523646;5873.353931067664;7028.859422811617;7079.539829911039;7184.030155929092;7503.324700776956;7582.393408527194;7593.05086864142;7600.923990760021;7622.226997636206;4799.832005879777;4810.42274927011;4817.7350245736825;4829.251466022772;4829.806807727651;5922.289325280994;7242.493025488166;7245.891311630225;7246.855062898818;7266.527675701274;6739.359760822714;7007.299270073156;7011.228764835762;7024.719011239493;7030.050943122613;6919.93080069213;6954.478414119062;6972.616506092214;6999.930000699927;7012.614306213207;6840.965795170992;6842.726290948306;6857.417119544894;6857.897131543131;6863.416609588241;6711.597304161571;6921.965390173017;7015.543989640657;7017.614031228331;7031.191412987572;5363.5440987516495;6575.473962083118;6708.496862735216;6861.588304701734;6874.931250687429 10:33:38 INFO - PROCESS | 2515 | |5;yui.html;666.183924692252;691.930806919308;695.0859619600222;709.4395427612187;775.9728409505665;14960.251987400627;15184.164870932094;15415.997960132583;15486.61283467914;15521.991070580405;14213.431462741479;14260.500882469116;14263.215523146222;14265.215413152273;14326.355314010869;920.3465539466987;938.2025278513278;944.2446043165475;948.9857652135223;950.8906475755273;760.163819798223;766.7009866152205;914.3599480363772;920.8388532006873;953.3612479638658;998.241336584194;1002.5438425516409;1003.2074661017787;1004.9547770350315;1008.1229330482454;992.8135877626239;992.9007099290086;994.140068840455;997.1524204426253;1001.3891526169031;583.956203284751;584.9064149736022;594.2898236607256;598.1237487081446;732.1909290234267;15207.923960380127;15210.695786084216;15213.163276019925;15231;15236.771448428282;12319.753604927851;12421.627351179388;12560.183588066746;12653.936730316382;12659.987201023989;10060.295779295453;10261.486925653688;10344.844827327595;10446;10773.407462589554;3423.178437175085;3488.0930957951114;3522.7886326820217;3551.5560554930635;3747.3442147624055;84852;85918.71121933113;86515.83710407227;86539;86920.13079869184;9417.576209070608;9492.240620750323;9493.715188544355;9763.072508111718;9864.408135511892;21696;21751;21778.782212177677;21794.564108717736;21795.67306490404;6475.449586785082;7389.852202955911;7445.0321458211165;7484.700611975569;7612.2387761224545;4054.189162167578;4113.732607380511;4125.608067233668;4132;4138.441310423114;2981.7774712367827;3520.5423294972;3533.381658209803;3539.5134043701705;3540.451230059345;640.3724350136891;640.679660169915;643.3598569423453;663.0154220981838;665.9667016649245;577.4668849531147;584.5411352088676;595.5146555557207;609.2719200555382;614.3119705929388;8107.797305067421;8179.79550511242;8274.503529788231;8310.459820111673;8419.494830310201;520.1183993131681;527.8363707250764;559.4796838939744;603.2489550509556;616.1835567872587;3618.330608837321;3813.84744610218;3837.2517359115263;3849.7690138591774;4038.7778672173313;86553;90236;95481.04518954722;96346;99366;71523.6423817888;75888;76749;80593;81144.59427702942;72818;73078.80763577101;73673;74640.62679686566;74765.62617186879;6513.381228783258;7610.505317154367;7630.969819074354;7806.141324454419;7919.866776029765;49859.75350616263;50152.49847501624;51536.742316288175;51827.74086129696;52541.474585255186;70177.64911175412;70732;71374;72096.63951680208;72278.63860680663;10018.3488073275;10077.294589378673;10173.949130254301;10268.486575671335;10330.225233107698;10877.728056798327;10936.234463587472;11157.66527004191;11335.603253886075;11875.821862671894;9127.201409698637;9221.677241296791;9384.155426011692;9600.375975561567;9668.56491457872;10027.398356098658;10213.642522511676;10265;10510.579576816841;10603.628872989408;9980.2514811388;10427.895721042692;10432.478376081317;10481.475926203811;10496.317739347223;8801.25189358886;8802;8855.73432797017;9034.548272586213;9051.592678329624;8193.67225310981;8537.786555336166;8817.779555511164;8893;9012.098790121197 10:33:38 INFO - PROCESS | 2515 | __end_tp_report 10:33:38 INFO - PROCESS | 2515 | __start_cc_report 10:33:38 INFO - PROCESS | 2515 | _x_x_mozilla_cycle_collect,1823 10:33:38 INFO - PROCESS | 2515 | __end_cc_report 10:33:38 INFO - PROCESS | 2515 | __startTimestamp1459186418898__endTimestamp 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | ------- Summary: start ------- 10:33:38 INFO - PROCESS | 2515 | Number of tests: 6 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#0] dojo.html Cycles:165 Average:5551.57 Median:5753.25 stddev:603.88 (10.5%) stddev-sans-first:579.27 10:33:38 INFO - PROCESS | 2515 | Values: 3297.9 3373.2 3404.7 3411.9 3442.4 5422.6 5480.6 5488.1 5490.7 5531.9 5482.0 5519.6 5538.3 5664.3 5667.4 4987.4 5000.7 5028.4 5056.7 5192.7 5112.4 5119.4 5139.1 5147.7 5152.6 4974.5 4992.8 5076.6 5080.8 5121.9 5062.3 5065.3 5072.0 5079.5 5117.8 5002.5 5056.1 5062.6 5063.9 5087.5 5319.4 5395.1 5406.5 5421.6 5519.5 5983.2 5997.5 6003.8 6012.5 6017.1 6038.9 6098.1 6107.4 6121.0 6124.1 5499.3 5572.0 5603.6 5658.4 5685.8 6178.0 6197.1 6202.5 6204.9 6214.8 4805.7 5789.5 5853.8 5866.9 5925.1 5904.7 5992.9 5997.7 6057.2 6095.7 5957.1 5962.1 5967.7 5978.4 5993.1 6009.5 6017.1 6025.3 6035.0 6035.9 4685.5 4704.3 4764.2 4770.7 4779.5 4256.8 4290.4 4333.2 4353.8 4376.5 5408.2 5415.3 5449.5 5457.7 5504.3 5879.3 6018.7 6051.0 6060.6 6074.9 5373.9 5381.4 5439.4 5480.0 5481.3 5153.1 5164.9 5181.1 5184.8 5215.2 6141.9 6208.5 6231.1 6269.3 6278.0 5915.9 5979.0 6047.5 6072.9 6091.3 6208.8 6224.1 6264.4 6278.8 6302.7 5783.3 5904.7 5910.0 5916.3 5975.6 5951.2 5959.1 6002.8 6075.8 6094.6 5763.7 5768.4 5770.2 5781.8 5784.8 5704.1 5781.0 5800.8 5815.6 5826.4 5669.0 5684.0 5684.3 5685.4 5710.3 5766.3 5844.5 5853.0 5885.4 5889.4 5753.3 5762.8 5770.3 5770.7 5784.7 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#1] ext.html Cycles:180 Average:56996.43 Median:37450.72 stddev:115595.17 (308.7%) stddev-sans-first:115841.54 10:33:38 INFO - PROCESS | 2515 | Values: 469.9 522.2 576.1 609.7 639.3 29420.3 37948.6 38394.0 38435.8 38480.6 41753.8 41940.4 42113.4 42140.0 42323.4 9423.5 9658.7 9666.8 9667.6 9691.3 9503.7 9643.6 9661.9 9674.6 9783.0 9712.5 9790.6 9809.7 9821.6 9822.9 9685.9 9784.4 9787.2 9792.9 9793.0 9638.3 9686.7 9691.8 9706.9 9777.2 39432.6 39475.4 39493.6 39996.6 40293.8 2811.4 3241.2 3392.7 3598.2 3804.5 28670.9 28967.0 29275.4 29309.4 29360.6 2719.9 2744.3 2754.6 2765.3 2891.4 384001.0 384616.0 385088.0 385510.0 385876.0 45734.0 67364.7 67951.0 67991.0 68249.3 45314.0 45509.5 45543.3 45675.5 45794.0 15484.7 15832.8 15863.3 15877.4 15882.9 12756.8 12807.3 12819.9 12842.5 12870.9 12214.0 12610.5 14448.5 14477.3 14701.9 5421.5 5493.4 6132.7 6327.5 6429.6 976.7 980.7 1023.6 1064.2 1095.0 21181.5 23593.1 29736.6 29793.9 29935.1 997.9 1052.9 1104.5 1111.8 1148.4 14327.6 14845.9 14862.2 15067.0 15170.0 549599.5 552635.0 556028.0 561005.0 561257.0 59237.0 59769.0 59781.0 59798.7 60027.0 1342.4 1447.1 1454.9 1476.8 1497.0 28105.6 28116.7 28761.7 28881.0 29030.6 41594.6 45857.8 46770.3 46844.0 46965.5 328106.0 330155.0 330495.7 330544.3 331181.0 28554.3 32587.8 33149.8 33565.0 33810.7 41702.2 42745.6 44157.3 44301.6 45782.0 35313.8 36408.6 36825.3 37206.9 37233.4 35825.6 36139.3 36200.5 36830.6 36895.0 36353.6 36488.3 37040.6 37390.4 37511.0 28261.4 30132.7 32114.0 32183.0 32488.2 24167.4 24306.3 24460.4 24606.1 24830.6 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#2] jquery.html Cycles:180 Average:27890.44 Median:21196.65 stddev:72735.84 (343.1%) stddev-sans-first:72910.51 10:33:38 INFO - PROCESS | 2515 | Values: 358.8 362.8 363.0 371.3 375.4 19815.6 20576.7 20632.2 20798.8 21146.8 19633.4 19695.2 20430.2 20450.3 20629.0 5593.5 5746.7 5804.5 5809.1 5815.1 4161.3 4345.8 5765.3 6472.5 6472.6 6201.7 6357.4 6362.0 6380.0 6388.4 6023.3 6331.2 6451.9 6454.6 6478.6 5560.6 5567.4 5580.7 5581.9 5585.8 21246.5 25566.0 25930.6 26167.6 26358.3 2110.3 2139.6 2195.6 2196.3 2274.7 14723.0 14740.0 14825.3 15129.9 15333.7 1420.9 1703.5 1722.4 1748.8 1822.6 98831.0 99830.0 102487.0 102546.5 103327.0 10004.7 10397.1 10436.6 10459.0 10531.1 12751.9 12863.6 12875.7 12898.2 12913.0 8410.5 8591.7 8613.5 8703.9 8704.7 8049.0 8870.0 8883.7 8907.1 8975.7 5535.3 6028.2 6028.4 6035.8 6131.9 1732.2 1768.3 1775.0 1778.5 1787.4 914.7 961.8 977.6 1026.9 1047.4 20372.0 20567.4 20951.6 21012.8 21312.5 840.0 967.7 972.2 1041.4 1090.9 10228.3 11048.9 11362.0 11386.3 11426.0 248017.8 248391.8 326990.0 515479.0 658942.0 102998.0 103017.0 105482.0 105681.0 106261.5 1035.2 1040.1 1055.3 1057.0 1059.6 18238.0 18465.0 18558.5 18560.0 18973.8 36616.8 46797.5 47240.1 47245.5 47812.6 62965.7 63148.4 64054.0 64221.0 64291.7 7686.1 7762.4 7775.0 7801.2 8087.5 12291.6 12835.4 12844.8 12845.5 13104.0 9833.2 10886.7 11252.5 11409.7 11528.3 10794.2 10814.4 11049.2 11053.8 11290.3 11328.5 11467.7 11470.3 11630.6 11638.2 7617.2 7656.4 7772.4 7814.5 8012.0 11154.9 11186.7 11500.1 11542.4 11588.4 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#3] mootools.html Cycles:180 Average:6143.50 Median:531.24 stddev:3271.99 (615.9%) stddev-sans-first:3261.88 10:33:38 INFO - PROCESS | 2515 | Values: 1416.3 1551.6 1631.1 1914.2 2053.6 8026.6 8738.7 8936.8 8939.9 8940.6 8537.3 8653.1 8680.5 8683.4 8858.9 2183.8 2420.8 2473.7 2498.5 2502.1 2088.4 2510.8 2515.7 2519.1 2522.2 2058.5 2420.1 2450.5 2451.7 2471.9 2423.7 2464.0 2469.7 2471.9 2485.7 2418.3 2465.3 2482.7 2486.9 2487.3 8893.5 8993.4 9002.6 9003.0 9026.7 5487.7 5505.1 5566.0 5667.6 5679.3 2983.0 3636.7 3693.2 3700.0 3745.4 1048.9 1065.3 1065.8 1076.4 1080.0 11036.9 11448.1 12130.3 12191.1 12238.8 4894.1 4894.5 4931.0 4943.1 4962.8 8650.0 10236.3 10236.8 10242.5 10285.2 5542.7 5564.7 5580.1 5586.1 5590.9 4465.1 4614.3 4950.4 5051.1 5059.6 3865.9 3916.7 3932.9 3958.1 3973.6 1301.4 1314.7 1320.6 1330.9 1331.9 1346.4 1364.3 1383.7 1406.8 1415.8 8463.5 8536.9 8570.0 8571.3 8577.8 526.4 526.5 530.4 532.1 536.0 6341.2 6346.8 6398.5 6405.4 6424.8 10725.5 10998.6 11133.8 11147.0 11158.5 10718.8 10806.4 10871.2 10944.7 10990.6 8495.4 8533.6 8574.2 8611.6 8643.7 7994.2 8112.4 8135.6 8176.0 8198.1 9348.6 9543.0 9773.0 9814.4 9933.3 9871.9 10063.2 10177.8 10245.2 10253.0 7691.5 7693.8 7724.5 7786.8 7809.8 8445.5 8464.7 8520.3 8521.6 8558.1 6577.9 7462.8 7657.4 7749.1 7762.3 6524.4 7439.2 7502.5 7504.9 7638.7 7984.3 8004.1 8019.9 8026.1 8075.0 6028.7 6865.2 7125.4 7204.0 7258.9 7202.0 7224.1 7254.9 7255.5 7268.5 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#4] prototype.html Cycles:180 Average:5659.12 Median:6352.22 stddev:1822.07 (28.7%) stddev-sans-first:1782.03 10:33:38 INFO - PROCESS | 2515 | Values: 288.2 329.4 330.0 334.8 336.7 5339.4 5805.7 6428.2 6490.5 6511.9 6342.3 6417.7 6502.7 6516.2 6540.4 3521.9 4286.7 4759.8 4891.2 4893.8 4785.4 4822.1 4827.0 4839.0 4858.0 4718.7 4729.6 4773.2 4779.9 4783.9 4255.7 4392.9 4696.9 4824.3 4869.9 3779.0 4033.4 4109.7 4135.9 4151.7 6106.1 6210.3 6229.3 6236.3 6270.8 4674.2 5676.2 5686.1 5699.4 5707.4 6293.9 6923.7 6935.5 6938.0 6956.2 3842.3 4510.4 4681.4 4695.3 4700.1 5753.6 7198.9 7268.3 7366.0 7372.1 4788.9 4797.9 4800.7 4803.0 4803.5 4852.9 4861.1 4862.8 4873.3 4876.8 4211.9 4949.4 5474.9 5761.0 5772.5 6794.9 6903.3 6977.3 7012.8 7034.6 1247.8 1666.5 1690.6 1693.4 1696.8 1031.1 1087.7 1090.7 1105.1 1108.6 5394.1 6179.3 6362.1 6530.5 6554.4 7247.0 7275.0 7284.7 7287.4 7298.1 6477.0 6494.4 6512.0 6512.4 6513.4 3438.6 3797.6 3843.9 3853.2 3855.6 6702.8 7601.7 7637.4 7666.5 7677.4 7460.8 7515.0 7523.2 7533.0 7543.5 7616.3 7627.5 7628.4 7631.0 7636.2 6986.3 7244.5 7246.2 7260.2 7262.5 5236.9 5873.4 7028.9 7079.5 7184.0 7503.3 7582.4 7593.1 7600.9 7622.2 4799.8 4810.4 4817.7 4829.3 4829.8 5922.3 7242.5 7245.9 7246.9 7266.5 6739.4 7007.3 7011.2 7024.7 7030.1 6919.9 6954.5 6972.6 6999.9 7012.6 6841.0 6842.7 6857.4 6857.9 6863.4 6711.6 6922.0 7015.5 7017.6 7031.2 5363.5 6575.5 6708.5 6861.6 6874.9 10:33:38 INFO - PROCESS | 2515 | 10:33:38 INFO - PROCESS | 2515 | [#5] yui.html Cycles:180 Average:18508.19 Median:611.79 stddev:26648.80 (4355.9%) stddev-sans-first:26689.89 10:33:38 INFO - PROCESS | 2515 | Values: 666.2 691.9 695.1 709.4 776.0 14960.3 15184.2 15416.0 15486.6 15522.0 14213.4 14260.5 14263.2 14265.2 14326.4 920.3 938.2 944.2 949.0 950.9 760.2 766.7 914.4 920.8 953.4 998.2 1002.5 1003.2 1005.0 1008.1 992.8 992.9 994.1 997.2 1001.4 584.0 584.9 594.3 598.1 732.2 15207.9 15210.7 15213.2 15231.0 15236.8 12319.8 12421.6 12560.2 12653.9 12660.0 10060.3 10261.5 10344.8 10446.0 10773.4 3423.2 3488.1 3522.8 3551.6 3747.3 84852.0 85918.7 86515.8 86539.0 86920.1 9417.6 9492.2 9493.7 9763.1 9864.4 21696.0 21751.0 21778.8 21794.6 21795.7 6475.4 7389.9 7445.0 7484.7 7612.2 4054.2 4113.7 4125.6 4132.0 4138.4 2981.8 3520.5 3533.4 3539.5 3540.5 640.4 640.7 643.4 663.0 666.0 577.5 584.5 595.5 609.3 614.3 8107.8 8179.8 8274.5 8310.5 8419.5 520.1 527.8 559.5 603.2 616.2 3618.3 3813.8 3837.3 3849.8 4038.8 86553.0 90236.0 95481.0 96346.0 99366.0 71523.6 75888.0 76749.0 80593.0 81144.6 72818.0 73078.8 73673.0 74640.6 74765.6 6513.4 7610.5 7631.0 7806.1 7919.9 49859.8 50152.5 51536.7 51827.7 52541.5 70177.6 70732.0 71374.0 72096.6 72278.6 10018.3 10077.3 10173.9 10268.5 10330.2 10877.7 10936.2 11157.7 11335.6 11875.8 9127.2 9221.7 9384.2 9600.4 9668.6 10027.4 10213.6 10265.0 10510.6 10603.6 9980.3 10427.9 10432.5 10481.5 10496.3 8801.3 8802.0 8855.7 9034.5 9051.6 8193.7 8537.8 8817.8 8893.0 9012.1 10:33:38 INFO - PROCESS | 2515 | -------- Summary: end -------- 10:33:38 INFO - PROCESS | 2515 | 10:33:39 INFO - TEST-INFO | 2515: exit 0 10:33:39 INFO - TEST-OK | dromaeo_css | took 1113035ms 10:33:39 INFO - TEST-START | kraken 10:33:39 INFO - operating with platform_type : mac_ 10:33:39 INFO - Initialising browser for kraken test... 10:33:39 INFO - TEST-INFO | started process 2522 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmp2eAjuO/profile http://localhost:57680/getInfo.html) 10:33:41 INFO - PROCESS | 2522 | __metrics Screen width/height:1600/1200 10:33:41 INFO - PROCESS | 2522 | colorDepth:24 10:33:41 INFO - PROCESS | 2522 | Browser inner width/height: 1024/689 10:33:41 INFO - PROCESS | 2522 | __metrics 10:33:41 INFO - PROCESS | 2522 | 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" 10:33:41 ERROR - PROCESS | 2522 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:33:42 INFO - TEST-INFO | 2522: exit 0 10:33:42 INFO - Browser initialized. 10:33:42 INFO - Running cycle 1/1 for kraken test... 10:33:42 INFO - TEST-INFO | started process 2524 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/10/1x852mss3jl9sjlsx99svtn400000w/T/tmp2eAjuO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:54 INFO - PROCESS | 2524 | RSS: Main: 244166656 10:33:54 INFO - PROCESS | 2524 | 10:33:56 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57680/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:57 INFO - PROCESS | 2524 | RSS: Main: 290508800 10:33:57 INFO - PROCESS | 2524 | 10:34:00 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57680/tests/kraken/driver.html?testName=audio-dft) 10:34:00 INFO - PROCESS | 2524 | RSS: Main: 300646400 10:34:00 INFO - PROCESS | 2524 | 10:34:03 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57680/tests/kraken/driver.html?testName=audio-fft) 10:34:04 INFO - PROCESS | 2524 | RSS: Main: 286101504 10:34:04 INFO - PROCESS | 2524 | 10:34:06 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57680/tests/kraken/driver.html?testName=audio-oscillator) 10:34:07 INFO - PROCESS | 2524 | RSS: Main: 287432704 10:34:07 INFO - PROCESS | 2524 | 10:34:09 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57680/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:10 INFO - PROCESS | 2524 | RSS: Main: 289837056 10:34:10 INFO - PROCESS | 2524 | 10:34:12 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57680/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:13 INFO - PROCESS | 2524 | RSS: Main: 289812480 10:34:13 INFO - PROCESS | 2524 | 10:34:16 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57680/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:16 INFO - PROCESS | 2524 | RSS: Main: 290291712 10:34:16 INFO - PROCESS | 2524 | 10:34:19 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57680/tests/kraken/driver.html?testName=json-parse-financial) 10:34:20 INFO - PROCESS | 2524 | RSS: Main: 290398208 10:34:20 INFO - PROCESS | 2524 | 10:34:21 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57680/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:22 INFO - PROCESS | 2524 | RSS: Main: 324886528 10:34:22 INFO - PROCESS | 2524 | 10:34:24 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:24 INFO - PROCESS | 2524 | RSS: Main: 325083136 10:34:24 INFO - PROCESS | 2524 | 10:34:26 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:27 INFO - PROCESS | 2524 | RSS: Main: 331845632 10:34:27 INFO - PROCESS | 2524 | 10:34:30 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:30 INFO - PROCESS | 2524 | RSS: Main: 331776000 10:34:30 INFO - PROCESS | 2524 | 10:34:33 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:33 INFO - PROCESS | 2524 | RSS: Main: 331894784 10:34:33 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | Cycle 1(1): loaded http://localhost:57680/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57680/tests/kraken/driver.html?testName=ai-astar) 10:34:35 INFO - PROCESS | 2524 | RSS: Main: 394338304 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | __start_tp_report 10:34:35 INFO - PROCESS | 2524 | _x_x_mozilla_page_load 10:34:35 INFO - PROCESS | 2524 | _x_x_mozilla_page_load_details 10:34:35 INFO - PROCESS | 2524 | |i|pagename|runs| 10:34:35 INFO - PROCESS | 2524 | |0;ai-astar;111;109;111;111;112;113;119;111;110;111 10:34:35 INFO - PROCESS | 2524 | |1;audio-beat-detection;158;121;147;187;149;144;143;119;165;122 10:34:35 INFO - PROCESS | 2524 | |2;audio-dft;184;188;183;183;185;187;185;187;183;181 10:34:35 INFO - PROCESS | 2524 | |3;audio-fft;75;104;109;87;73;81;83;86;79;55 10:34:35 INFO - PROCESS | 2524 | |4;audio-oscillator;90;97;132;77;80;87;147;116;115;147 10:34:35 INFO - PROCESS | 2524 | |5;imaging-gaussian-blur;88;84;88;84;88;84;87;84;87;83 10:34:35 INFO - PROCESS | 2524 | |6;imaging-darkroom;92;92;93;93;92;92;93;93;92;92 10:34:35 INFO - PROCESS | 2524 | |7;imaging-desaturate;88;87;87;84;84;85;86;87;86;86 10:34:35 INFO - PROCESS | 2524 | |8;json-parse-financial;55;54;54;53;54;54;54;65;55;51 10:34:35 INFO - PROCESS | 2524 | |9;json-stringify-tinderbox;66;65;80;78;71;71;70;70;71;73 10:34:35 INFO - PROCESS | 2524 | |10;stanford-crypto-aes;83;84;83;92;107;84;82;84;84;85 10:34:35 INFO - PROCESS | 2524 | |11;stanford-crypto-ccm;123;138;129;116;108;140;129;129;123;132 10:34:35 INFO - PROCESS | 2524 | |12;stanford-crypto-pbkdf2;142;130;141;139;139;128;140;138;136;138 10:34:35 INFO - PROCESS | 2524 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;68;67;71;66;66 10:34:35 INFO - PROCESS | 2524 | __end_tp_report 10:34:35 INFO - PROCESS | 2524 | __start_cc_report 10:34:35 INFO - PROCESS | 2524 | _x_x_mozilla_cycle_collect,1248 10:34:35 INFO - PROCESS | 2524 | __end_cc_report 10:34:35 INFO - PROCESS | 2524 | __startTimestamp1459186475743__endTimestamp 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | ------- Summary: start ------- 10:34:35 INFO - PROCESS | 2524 | Number of tests: 14 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:2.74 (2.5%) stddev-sans-first:2.89 10:34:35 INFO - PROCESS | 2524 | Values: 111.0 109.0 111.0 111.0 112.0 113.0 119.0 111.0 110.0 111.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:148.00 stddev:21.44 (14.5%) stddev-sans-first:22.26 10:34:35 INFO - PROCESS | 2524 | Values: 158.0 121.0 147.0 187.0 149.0 144.0 143.0 119.0 165.0 122.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:2.22 (1.2%) stddev-sans-first:2.35 10:34:35 INFO - PROCESS | 2524 | Values: 184.0 188.0 183.0 183.0 185.0 187.0 185.0 187.0 183.0 181.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#3] audio-fft Cycles:10 Average:83.20 Median:80.00 stddev:15.31 (19.1%) stddev-sans-first:15.95 10:34:35 INFO - PROCESS | 2524 | Values: 75.0 104.0 109.0 87.0 73.0 81.0 83.0 86.0 79.0 55.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:78.50 stddev:26.57 (33.9%) stddev-sans-first:27.30 10:34:35 INFO - PROCESS | 2524 | Values: 90.0 97.0 132.0 77.0 80.0 87.0 147.0 116.0 115.0 147.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:2.06 (2.4%) stddev-sans-first:2.01 10:34:35 INFO - PROCESS | 2524 | Values: 88.0 84.0 88.0 84.0 88.0 84.0 87.0 84.0 87.0 83.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:92.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:34:35 INFO - PROCESS | 2524 | Values: 92.0 92.0 93.0 93.0 92.0 92.0 93.0 93.0 92.0 92.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.33 (1.5%) stddev-sans-first:1.20 10:34:35 INFO - PROCESS | 2524 | Values: 88.0 87.0 87.0 84.0 84.0 85.0 86.0 87.0 86.0 86.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.73 (6.9%) stddev-sans-first:3.95 10:34:35 INFO - PROCESS | 2524 | Values: 55.0 54.0 54.0 53.0 54.0 54.0 54.0 65.0 55.0 51.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:4.65 (6.5%) stddev-sans-first:4.48 10:34:35 INFO - PROCESS | 2524 | Values: 66.0 65.0 80.0 78.0 71.0 71.0 70.0 70.0 71.0 73.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.00 stddev:7.61 (9.1%) stddev-sans-first:7.95 10:34:35 INFO - PROCESS | 2524 | Values: 83.0 84.0 83.0 92.0 107.0 84.0 82.0 84.0 84.0 85.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:129.00 stddev:9.66 (7.5%) stddev-sans-first:10.15 10:34:35 INFO - PROCESS | 2524 | Values: 123.0 138.0 129.0 116.0 108.0 140.0 129.0 129.0 123.0 132.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:139.00 stddev:4.61 (3.3%) stddev-sans-first:4.53 10:34:35 INFO - PROCESS | 2524 | Values: 142.0 130.0 141.0 139.0 139.0 128.0 140.0 138.0 136.0 138.0 10:34:35 INFO - PROCESS | 2524 | 10:34:35 INFO - PROCESS | 2524 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 10:34:35 INFO - PROCESS | 2524 | Values: 67.0 67.0 67.0 66.0 68.0 68.0 67.0 71.0 66.0 66.0 10:34:35 INFO - PROCESS | 2524 | -------- Summary: end -------- 10:34:35 INFO - PROCESS | 2524 | 10:34:36 INFO - TEST-INFO | 2524: exit 0 10:34:36 INFO - TEST-OK | kraken | took 57138ms 10:34:36 INFO - SUITE-END | took 1170s 10:34:36 INFO - Completed test suite (00:19:30) 10:34:36 INFO - javascript benchmark 10:34:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3297.868085276589, 3373.156710822293, 3404.727621790257, 3411.8805841795534, 3442.3631628148796, 5422.647527910693, 5480.561555075595, 5488.121900495921, 5490.725463726818, 5531.944680553198, 5482.0, 5519.613627046108, 5538.335399752025, 5664.291963504562, 5667.376588575254, 4987.351644286237, 5000.749962501878, 5028.446870844205, 5056.721880296583, 5192.688438693691, 5112.437631860493, 5119.411267704225, 5139.100657384962, 5147.691138531682, 5152.562032227265, 4974.527419895104, 4992.775325110379, 5076.619253555979, 5080.79676812927, 5121.871953201163, 5062.341895553554, 5065.316182315414, 5072.036313100499, 5079.466656001141, 5117.795288188505, 5002.549770520634, 5056.115179843549, 5062.594992400599, 5063.873403164914, 5087.516685914832, 5319.3616765987945, 5395.10980688186, 5406.486383793534, 5421.620486565942, 5519.503244707956, 5983.1623572699855, 5997.460228579405, 6003.759849606055, 6012.518998480111, 6017.127516510125, 6038.939610603926, 6098.1157732128595, 6107.4197951194565, 6120.990036643949, 6124.11200375943, 5499.312585926759, 5571.9721401392735, 5603.60774745768, 5658.405867383948, 5685.800996965087, 6178.011518157163, 6197.070439434031, 6202.503799696014, 6204.875902481925, 6214.844628884314, 4805.711657300573, 5789.478946894799, 5853.795117170878, 5866.882662346729, 5925.081612350093, 5904.7342869570975, 5992.940070599326, 5997.670128142907, 6057.151998720183, 6095.6952152392205, 5957.106434034929, 5962.135490353874, 5967.701614919237, 5978.372270911578, 5993.101034844721, 6009.549283803733, 6017.097435384728, 6025.3372129065765, 6034.969825150846, 6035.909461358083, 4685.461171965268, 4704.341392205094, 4764.190087685102, 4770.737609431515, 4779.450363208206, 4256.787160641956, 4290.420793192879, 4333.241682705514, 4353.804078816461, 4376.518582955872, 5408.161734931092, 5415.323084614423, 5449.455054494519, 5457.672539647634, 5504.284443022381, 5879.323877754027, 6018.668973206516, 6051.031834906482, 6060.636361818217, 6074.908876366858, 5373.919391209135, 5381.434949330264, 5439.428859969726, 5479.958807826501, 5481.314835645544, 5153.098207813618, 5164.948350516522, 5181.145111056633, 5184.844454666366, 5215.217717342429, 6141.907871382022, 6208.534359923024, 6231.065340199007, 6269.310375858743, 6278.0269058296035, 5915.852103697442, 5978.970105149447, 6047.516198704006, 6072.939270607414, 6091.269047714125, 6208.81373558794, 6224.06639004153, 6264.373562643699, 6278.780242691484, 6302.747890084345, 5783.334916484658, 5904.704764761831, 5909.970450147722, 5916.26046744157, 5975.581709280309, 5951.166836642787, 5959.135925290895, 6002.819915402545, 6075.848103797441, 6094.573379863367, 5763.682997435181, 5768.423157684198, 5770.163326317745, 5781.79763708285, 5784.82645520635, 5704.1443783432815, 5781.0, 5800.76796928135, 5815.5929084963645, 5826.41735826414, 5669.036263835241, 5684.033714268501, 5684.289463817023, 5685.431456854447, 5710.2576665033275, 5766.3368712598585, 5844.503217226584, 5853.03424934881, 5885.411458854252, 5889.38161493037, 5753.252077229933, 5762.769489220552, 5770.336411312753, 5770.682612456355, 5784.681842498535], "unit": "score", "name": "dojo.html", "value": 5514.39845704792}, {"lowerIsBetter": false, "replicates": [469.87465021274073, 522.2401405954337, 576.0552693582525, 609.734765377061, 639.3159319528107, 29420.264493387676, 37948.62051379486, 38394.04014899625, 38435.846924592304, 38480.615193848054, 41753.79123104388, 41940.37089443653, 42113.36829947553, 42140.0, 42323.3651495227, 9423.481708506013, 9658.661946831862, 9666.806663866719, 9667.5649595768, 9691.321607487478, 9503.714888553355, 9643.566039528203, 9661.903380966205, 9674.564644590975, 9782.9510852446, 9712.514374281292, 9790.608375664964, 9809.705708828747, 9821.607135714563, 9822.852657210147, 9685.90314096857, 9784.364016338986, 9787.217022638242, 9792.853107203398, 9793.020697930186, 9638.325317227796, 9686.70939871805, 9691.806163876754, 9706.90293097074, 9777.217822574177, 39432.60567394318, 39475.407868881986, 39493.60506394928, 39996.60003399958, 40293.79118626446, 2811.3955499567487, 3241.2059045533997, 3392.6607339266125, 3598.226381328027, 3804.4673745675627, 28670.856645716845, 28967.0, 29275.41449171026, 29309.413811723858, 29360.56829486552, 2719.8504082275467, 2744.2727677165567, 2754.614353990443, 2765.3224959884956, 2891.3783536539745, 384001.0, 384616.0, 385087.9999999972, 385510.0, 385876.0, 45734.0, 67364.6631766838, 67951.0, 67991.0, 68249.31750682529, 45314.0, 45509.54490455119, 45543.316850247276, 45675.54324456713, 45794.0, 15484.690306193814, 15832.76250856238, 15863.286152123183, 15877.364905403654, 15882.92058539723, 12756.80864787029, 12807.295598741972, 12819.935900320439, 12842.48630054806, 12870.905972992401, 12214.0, 12610.495580176874, 14448.494302699355, 14477.276136193148, 14701.852981470049, 5421.539169170585, 5493.423190565013, 6132.724027418777, 6327.475854763774, 6429.553350496194, 976.6532880827347, 980.7499087732582, 1023.6212601337404, 1064.2018486135398, 1094.9835752463719, 21181.470463238544, 23593.05627774904, 29736.55395169074, 29793.85103074514, 29935.103010306244, 997.870276864003, 1052.8526006358964, 1104.4588151805558, 1111.8054340490382, 1148.3970915269383, 14327.641808954859, 14845.886558508155, 14862.182579958206, 15067.0, 15170.0, 549599.5040049629, 552635.0, 556028.0, 561005.0, 561257.0, 59237.0, 59769.0, 59781.0, 59798.70100649556, 60027.0, 1342.4026308292716, 1447.1317209674112, 1454.905431146972, 1476.837547869712, 1496.9850301497063, 28105.578416323362, 28116.71883281141, 28761.712382875903, 28881.0, 29030.564541532316, 41594.58405416028, 45857.77071114623, 46770.29844552402, 46844.0, 46965.53034469612, 328106.0, 330155.0, 330495.6950430561, 330544.3472782621, 331181.0, 28554.286142846595, 32587.837060814545, 33149.83975560844, 33564.99305020853, 33810.661893380755, 41702.1659566813, 42745.572544275405, 44157.33763993607, 44301.55698443103, 45782.0, 35313.82343088268, 36408.63591364052, 36825.26349473049, 37206.88379348624, 37233.44149837809, 35825.64174358223, 36139.27721445609, 36200.456993144595, 36830.63169368272, 36895.0, 36353.63646363608, 36488.27023459569, 37040.6295937048, 37390.439143413416, 37511.0, 28261.434771304048, 30132.69867301299, 32114.03657890267, 32183.0, 32488.187795304362, 24167.352332510112, 24306.27081187567, 24460.388490287885, 24606.13878514315, 24830.627540587266], "unit": "score", "name": "ext.html", "value": 18786.539281782887}, {"lowerIsBetter": false, "replicates": [358.7542533364645, 362.76057801850783, 362.97640653357524, 371.2982463144657, 375.38436963380076, 19815.60368792625, 20576.69134962975, 20632.1747130115, 20798.792012079874, 21146.836923969175, 19633.410997670093, 19695.21219151232, 20430.182792688312, 20450.284240051602, 20629.0, 5593.52455041321, 5746.712664366765, 5804.477597016267, 5809.070548712207, 5815.098659707752, 4161.25097482453, 4345.760983145926, 5765.336986246593, 6472.482201423898, 6472.644004579746, 6201.658908760039, 6357.427831495164, 6361.968190159043, 6379.968100159493, 6388.425041746242, 6023.277206735198, 6331.163962450883, 6451.903221451682, 6454.6449945253225, 6478.578892371981, 5560.638558493725, 5567.359753628303, 5580.665160090408, 5581.944180558183, 5585.804496842591, 21246.468838279012, 25566.0, 25930.573818439978, 26167.607485887725, 26358.341041473926, 2110.2719561751323, 2139.6469582518866, 2195.5718634866207, 2196.2752291743686, 2274.6701728249477, 14723.0, 14739.96820222585, 14825.258737063104, 15129.924350378178, 15333.693326133527, 1420.8721215090588, 1703.4548944337816, 1722.4488163787594, 1748.8338607832236, 1822.589917268604, 98831.0, 99830.0, 102486.9751302485, 102546.48726756393, 103327.0, 10004.699859004242, 10397.11624511925, 10436.63471778484, 10459.0, 10531.104856087166, 12751.936240318739, 12863.614091577268, 12875.678108047186, 12898.226106433456, 12912.998485234804, 8410.49537027768, 8591.6992905248, 8613.526256055851, 8703.86944195825, 8704.738857834274, 8048.993875765529, 8869.955650221707, 8883.689070882618, 8907.064758200426, 8975.730728078037, 5535.33575970878, 6028.196888446893, 6028.367021462684, 6035.758569657164, 6131.877362452726, 1732.229158024667, 1768.32803534656, 1774.97337539937, 1778.5286898971783, 1787.4012205911165, 914.7210100919284, 961.8124465729255, 977.6089564174387, 1026.8665073540392, 1047.4291511126455, 20371.981400929893, 20567.38297851067, 20951.58096838085, 21012.789872101388, 21312.467188320104, 839.9706010289733, 967.670991862756, 972.1736523954723, 1041.4063983529315, 1090.8690957085041, 10228.284020118668, 11048.889511104786, 11362.0, 11386.316820990767, 11426.028787552985, 248017.75991120288, 248391.75804120864, 326990.0, 515479.0, 658942.0, 102998.0, 103017.0, 105482.0, 105681.0, 106261.46869265758, 1035.1615191694752, 1040.0587468341164, 1055.256044488649, 1057.043375744952, 1059.5655781129853, 18238.0, 18465.0, 18558.536036598653, 18560.0, 18973.810261897204, 36616.81691591525, 46797.53202467932, 47240.05519889514, 47245.527544724115, 47812.56562303136, 62965.68517157385, 63148.36851631425, 64054.03918941126, 64221.0, 64291.67854160699, 7686.077670679554, 7762.41781866351, 7775.0, 7801.1808760079375, 8087.514749115072, 12291.631251062483, 12835.42240599194, 12844.807327890276, 12845.486180552673, 13104.017198710326, 9833.213342932691, 10886.67339979802, 11252.493637786483, 11409.657710268706, 11528.250663706833, 10794.244402891722, 10814.405207713651, 11049.226554141133, 11053.834192486958, 11290.266132701348, 11328.490217940047, 11467.655970320904, 11470.311781293149, 11630.592929247436, 11638.185327027028, 7617.200193979774, 7656.425768067305, 7772.417068719756, 7814.53112813233, 8012.0, 11154.888451115385, 11186.664400068012, 11500.137489688474, 11542.365169915734, 11588.420578971187], "unit": "score", "name": "jquery.html", "value": 9386.377080705537}, {"lowerIsBetter": false, "replicates": [1416.2564653556888, 1551.612096975756, 1631.0784406810155, 1914.186470749932, 2053.6200802851463, 8026.598670066495, 8738.694145704902, 8936.776580585496, 8939.86590201146, 8940.59767310471, 8537.2743316818, 8653.134686531359, 8680.522571258594, 8683.43557668751, 8858.911410885888, 2183.836212284077, 2420.782129608335, 2473.690788651423, 2498.537770512452, 2502.099244272061, 2088.363049269972, 2510.8242423030397, 2515.6981162260463, 2519.143491212987, 2522.1676846640657, 2058.547119633678, 2420.068273714615, 2450.546648869965, 2451.7180524239675, 2471.925842224727, 2423.6970378702663, 2463.987680061606, 2469.6789417375717, 2471.9134830280946, 2485.7389974052644, 2418.322869596516, 2465.3466831289725, 2482.7020757509035, 2486.8632225227607, 2487.2911220302126, 8893.4663920165, 8993.415427997159, 9002.639894404216, 9003.00966893641, 9026.684066057656, 5487.725613719338, 5505.146702261156, 5566.0, 5667.603267771257, 5679.318481782171, 2982.9850850745606, 3636.690881275095, 3693.2244228712, 3699.963000370016, 3745.3632882410056, 1048.905598496139, 1065.339489516497, 1065.8294672852385, 1076.4187338837019, 1080.0387654987069, 11036.944815275952, 11448.141389395829, 12130.272183669009, 12191.085668574893, 12238.81641775374, 4894.094592500399, 4894.486078961729, 4931.038447502774, 4943.110240156806, 4962.826301079445, 8650.0, 10236.33463824864, 10236.846447303296, 10242.487875606339, 10285.22860785444, 5542.695151766691, 5564.693941833238, 5580.051391263495, 5586.1062230043, 5590.888182236333, 4465.106978604292, 4614.307853821886, 4950.381202349707, 5051.1413059779925, 5059.569936555434, 3865.9226815464094, 3916.7258291919293, 3932.8623498177426, 3958.089639382958, 3973.6026397360033, 1301.3753398368835, 1314.664760486089, 1320.5972178485654, 1330.8772507850158, 1331.8801307882336, 1346.4344975110478, 1364.283751030697, 1383.6955869708647, 1406.7678832992442, 1415.7876318552094, 8463.534505602127, 8536.8719469208, 8569.957150214334, 8571.314294856396, 8577.785555361166, 526.4393421006615, 526.5287567626953, 530.374158492982, 532.1060618161448, 535.9517643412112, 6341.175647165931, 6346.777862774781, 6398.488120950313, 6405.423511883952, 6424.807255782334, 10725.51735171919, 10998.615048473264, 11133.832992505118, 11147.0, 11158.497867595977, 10718.839217411745, 10806.405647689295, 10871.184661150288, 10944.726381840517, 10990.560377584807, 8495.405321627426, 8533.615987280464, 8574.185452382013, 8611.61247743853, 8643.654253829776, 7994.1606131355375, 8112.351011919151, 8135.593220339078, 8175.959120204361, 8198.057223419382, 9348.579313930753, 9543.0, 9773.0, 9814.362066465657, 9933.255005874733, 9871.851922221316, 10063.194944404284, 10177.847332289874, 10245.180385569285, 10253.0, 7691.50005249657, 7693.807654808675, 7724.497907635986, 7786.7663970080985, 7809.843803123792, 8445.535495547803, 8464.66141354339, 8520.318374530147, 8521.573921304034, 8558.101399352978, 6577.914644083673, 7462.813429664302, 7657.425693072931, 7749.108852482037, 7762.301392874669, 6524.412802847766, 7439.181690014202, 7502.549847009197, 7504.924950750423, 7638.694452222071, 7984.281414672707, 8004.079530854026, 8019.9198008019175, 8026.077001144943, 8075.030996280484, 6028.728707208274, 6865.176178858369, 7125.394341480825, 7204.0, 7258.89111663336, 7202.027726256888, 7224.13310402755, 7254.89117663246, 7255.455840811855, 7268.454865884974], "unit": "score", "name": "mootools.html", "value": 4916.421035831483}, {"lowerIsBetter": false, "replicates": [288.2361741385329, 329.364326849181, 329.96700329967007, 334.785737128238, 336.6582918337886, 5339.439358867321, 5805.680687562182, 6428.19647544057, 6490.513211509144, 6511.902321465182, 6342.334054924236, 6417.679116044203, 6502.7398904043785, 6516.218053833535, 6540.4440622547145, 3521.894343169696, 4286.699931004831, 4759.809607615691, 4891.241857512083, 4893.8042478301, 4785.401824771903, 4822.132016237076, 4826.975865120669, 4838.951610483885, 4858.0283943211325, 4718.693284936486, 4729.6452766042685, 4773.18855794514, 4779.928301075487, 4783.928241076386, 4255.723377980421, 4392.901774556345, 4696.929546056812, 4824.348712923746, 4869.853904382874, 3778.9796754876306, 4033.3949907513816, 4109.6506796922295, 4135.875923722293, 4151.6886233532605, 6106.114613381079, 6210.285817131043, 6229.345918678564, 6236.251649802008, 6270.7805226816845, 4674.228752255874, 5676.1769543416385, 5686.118651608966, 5699.404166833293, 5707.429257074301, 6293.9370606293805, 6923.723051077951, 6935.514513984023, 6937.993990871295, 6956.165260168812, 3842.346801043829, 4510.413646226002, 4681.368015317923, 4695.319178719101, 4700.130475861943, 5753.597248192628, 7198.892016619755, 7268.328284494596, 7366.0, 7372.115346158495, 4788.856334309976, 4797.928031079537, 4800.687955282895, 4803.0153818467825, 4803.543663351976, 4852.854414367504, 4861.149298872683, 4862.78117484714, 4873.342098816685, 4876.804927802848, 4211.947013246689, 4949.430815456197, 5474.91787623186, 5761.0, 5772.538196944234, 6794.939481042658, 6903.309669033157, 6977.33715297046, 7012.826023932597, 7034.6482675866, 1247.8440194975628, 1666.491720025404, 1690.636513149654, 1693.424235759823, 1696.8303169682933, 1031.1235449867552, 1087.6628245243999, 1090.7491277006334, 1105.077260487502, 1108.5953626926114, 5394.056040192951, 6179.258488981351, 6362.1093046973465, 6530.542861999615, 6554.442872355808, 7247.0, 7275.017872587239, 7284.6721897514735, 7287.380572651384, 7298.087739032621, 6477.0, 6494.4479719223455, 6511.967440162769, 6512.381323774234, 6513.413792758674, 3438.570178727659, 3797.5632802227547, 3843.9237013636225, 3853.190829925747, 3855.614438556178, 6702.832429189211, 7601.707709689366, 7637.3579680368985, 7666.501677390952, 7677.385809135256, 7460.813479663052, 7515.023047003964, 7523.247675232543, 7532.983047288546, 7543.547387156788, 7616.314531692175, 7627.504212226077, 7628.351590114791, 7631.0, 7636.236376362319, 6986.266442023514, 7244.4566657501955, 7246.1666908306215, 7260.165081015751, 7262.491625586158, 5236.947630523646, 5873.353931067664, 7028.859422811617, 7079.539829911039, 7184.030155929092, 7503.324700776956, 7582.393408527194, 7593.05086864142, 7600.923990760021, 7622.226997636206, 4799.832005879777, 4810.42274927011, 4817.7350245736825, 4829.251466022772, 4829.806807727651, 5922.289325280994, 7242.493025488166, 7245.891311630225, 7246.855062898818, 7266.527675701274, 6739.359760822714, 7007.299270073156, 7011.228764835762, 7024.719011239493, 7030.050943122613, 6919.93080069213, 6954.478414119062, 6972.616506092214, 6999.930000699927, 7012.614306213207, 6840.965795170992, 6842.726290948306, 6857.417119544894, 6857.897131543131, 6863.416609588241, 6711.597304161571, 6921.965390173017, 7015.543989640657, 7017.614031228331, 7031.191412987572, 5363.5440987516495, 6575.473962083118, 6708.496862735216, 6861.588304701734, 6874.931250687429], "unit": "score", "name": "prototype.html", "value": 5058.201774535662}, {"lowerIsBetter": false, "replicates": [666.183924692252, 691.930806919308, 695.0859619600222, 709.4395427612187, 775.9728409505665, 14960.251987400627, 15184.164870932094, 15415.997960132583, 15486.61283467914, 15521.991070580405, 14213.431462741479, 14260.500882469116, 14263.215523146222, 14265.215413152273, 14326.355314010869, 920.3465539466987, 938.2025278513278, 944.2446043165475, 948.9857652135223, 950.8906475755273, 760.163819798223, 766.7009866152205, 914.3599480363772, 920.8388532006873, 953.3612479638658, 998.241336584194, 1002.5438425516409, 1003.2074661017787, 1004.9547770350315, 1008.1229330482454, 992.8135877626239, 992.9007099290086, 994.140068840455, 997.1524204426253, 1001.3891526169031, 583.956203284751, 584.9064149736022, 594.2898236607256, 598.1237487081446, 732.1909290234267, 15207.923960380127, 15210.695786084216, 15213.163276019925, 15231.0, 15236.771448428282, 12319.753604927851, 12421.627351179388, 12560.183588066746, 12653.936730316382, 12659.987201023989, 10060.295779295453, 10261.486925653688, 10344.844827327595, 10446.0, 10773.407462589554, 3423.178437175085, 3488.0930957951114, 3522.7886326820217, 3551.5560554930635, 3747.3442147624055, 84852.0, 85918.71121933113, 86515.83710407227, 86539.0, 86920.13079869184, 9417.576209070608, 9492.240620750323, 9493.715188544355, 9763.072508111718, 9864.408135511892, 21696.0, 21751.0, 21778.782212177677, 21794.564108717736, 21795.67306490404, 6475.449586785082, 7389.852202955911, 7445.0321458211165, 7484.700611975569, 7612.2387761224545, 4054.189162167578, 4113.732607380511, 4125.608067233668, 4132.0, 4138.441310423114, 2981.7774712367827, 3520.5423294972, 3533.381658209803, 3539.5134043701705, 3540.451230059345, 640.3724350136891, 640.679660169915, 643.3598569423453, 663.0154220981838, 665.9667016649245, 577.4668849531147, 584.5411352088676, 595.5146555557207, 609.2719200555382, 614.3119705929388, 8107.797305067421, 8179.79550511242, 8274.503529788231, 8310.459820111673, 8419.494830310201, 520.1183993131681, 527.8363707250764, 559.4796838939744, 603.2489550509556, 616.1835567872587, 3618.330608837321, 3813.84744610218, 3837.2517359115263, 3849.7690138591774, 4038.7778672173313, 86553.0, 90236.0, 95481.04518954722, 96346.0, 99366.0, 71523.6423817888, 75888.0, 76749.0, 80593.0, 81144.59427702942, 72818.0, 73078.80763577101, 73673.0, 74640.62679686566, 74765.62617186879, 6513.381228783258, 7610.505317154367, 7630.969819074354, 7806.141324454419, 7919.866776029765, 49859.75350616263, 50152.49847501624, 51536.742316288175, 51827.74086129696, 52541.474585255186, 70177.64911175412, 70732.0, 71374.0, 72096.63951680208, 72278.63860680663, 10018.3488073275, 10077.294589378673, 10173.949130254301, 10268.486575671335, 10330.225233107698, 10877.728056798327, 10936.234463587472, 11157.66527004191, 11335.603253886075, 11875.821862671894, 9127.201409698637, 9221.677241296791, 9384.155426011692, 9600.375975561567, 9668.56491457872, 10027.398356098658, 10213.642522511676, 10265.0, 10510.579576816841, 10603.628872989408, 9980.2514811388, 10427.895721042692, 10432.478376081317, 10481.475926203811, 10496.317739347223, 8801.25189358886, 8802.0, 8855.73432797017, 9034.548272586213, 9051.592678329624, 8193.67225310981, 8537.786555336166, 8817.779555511164, 8893.0, 9012.098790121197], "unit": "score", "name": "yui.html", "value": 6796.048308795996}], "name": "dromaeo_css", "value": 7401.103188127737}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 111.0, 112.0, 113.0, 119.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [158.0, 121.0, 147.0, 187.0, 149.0, 144.0, 143.0, 119.0, 165.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [184.0, 188.0, 183.0, 183.0, 185.0, 187.0, 185.0, 187.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [75.0, 104.0, 109.0, 87.0, 73.0, 81.0, 83.0, 86.0, 79.0, 55.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [90.0, 97.0, 132.0, 77.0, 80.0, 87.0, 147.0, 116.0, 115.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 88.0, 84.0, 88.0, 84.0, 87.0, 84.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.4}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 87.0, 84.0, 84.0, 85.0, 86.0, 87.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 65.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 80.0, 78.0, 71.0, 71.0, 70.0, 70.0, 71.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 92.0, 107.0, 84.0, 82.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [123.0, 138.0, 129.0, 116.0, 108.0, 140.0, 129.0, 129.0, 123.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 141.0, 139.0, 139.0, 128.0, 140.0, 138.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 68.0, 67.0, 71.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1442.3}]} 10:34:36 INFO - Return code: 0 10:34:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:34:37 ERROR - # TBPL SUCCESS # 10:34:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:34:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:34:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:34:37 INFO - 2016-03-28 10:34:37.057 screenresolution[2528:24416] starting screenresolution argv=screenresolution get 10:34:37 INFO - 2016-03-28 10:34:37.060 screenresolution[2528:24416] Display 0: 1600x1200x32@60 10:34:37 INFO - 2016-03-28 10:34:37.066 screenresolution[2529:24419] starting screenresolution argv=screenresolution list 10:34:37 INFO - Available Modes on Display 0 10:34:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:34:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:34:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:34:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:34:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:34:37 INFO - Intel Iris: 10:34:37 INFO - Chipset Model: Intel Iris 10:34:37 INFO - Type: GPU 10:34:37 INFO - Bus: Built-In 10:34:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:34:37 INFO - Vendor: Intel (0x8086) 10:34:37 INFO - Device ID: 0x0a2e 10:34:37 INFO - Revision ID: 0x0009 10:34:37 INFO - Displays: 10:34:37 INFO - Display: 10:34:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:34:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:34:37 INFO - Display Serial Number: 1600x1200 60 10:34:37 INFO - Main Display: Yes 10:34:37 INFO - Mirror: Off 10:34:37 INFO - Online: Yes 10:34:37 INFO - Rotation: Supported 10:34:37 INFO - Return code: 0 10:34:37 INFO - Running post-action listener: _resource_record_post_action 10:34:37 INFO - Running post-run listener: _resource_record_post_run 10:34:38 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 11330560; Write bytes: 715490304; Read time: 176; Write time: 1938 10:34:38 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402932224; Write bytes: 404739584; Read time: 30265; Write time: 774 10:34:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 11330560; Write bytes: 309693952; Read time: 176; Write time: 1158 10:34:38 INFO - Running post-run listener: _upload_blobber_files 10:34:38 INFO - Blob upload gear active. 10:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:38 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 10:34:38 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'] 10:34:38 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 10:34:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:39 INFO - (blobuploader) - INFO - Done attempting. 10:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:40 INFO - (blobuploader) - INFO - Done attempting. 10:34:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:40 INFO - Return code: 0 10:34:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c46d3fd527b9de62355f2e1cff2ee59982923f496fd07068ad4a0bb0c70aa95504a696b112dc17e08a5ab0f6698198b872f1add3987097e50e3dae482da16b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a90b7db9c4c1a7d731af6b664014d5adcdae9aea8e4ef3b255caa8e0cb80b8eaaf9cbd8c9209ebd74f3eb6a5ea0bc6d9373fe9a14a5589dd1186e8ec061a6"} 10:34:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:40 INFO - Contents: 10:34:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c46d3fd527b9de62355f2e1cff2ee59982923f496fd07068ad4a0bb0c70aa95504a696b112dc17e08a5ab0f6698198b872f1add3987097e50e3dae482da16b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a90b7db9c4c1a7d731af6b664014d5adcdae9aea8e4ef3b255caa8e0cb80b8eaaf9cbd8c9209ebd74f3eb6a5ea0bc6d9373fe9a14a5589dd1186e8ec061a6"} 10:34:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:40 INFO - Copying logs to upload dir... 10:34:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.714087 ========= master_lag: 2.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-03-28 10:34:43.379445) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-28 10:34:43.381704) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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/c46d3fd527b9de62355f2e1cff2ee59982923f496fd07068ad4a0bb0c70aa95504a696b112dc17e08a5ab0f6698198b872f1add3987097e50e3dae482da16b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a90b7db9c4c1a7d731af6b664014d5adcdae9aea8e4ef3b255caa8e0cb80b8eaaf9cbd8c9209ebd74f3eb6a5ea0bc6d9373fe9a14a5589dd1186e8ec061a6"} build_url:https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010724 build_url: 'https://queue.taskcluster.net/v1/task/ZT1O_M8CSH-fiXKrhlaxtQ/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/c46d3fd527b9de62355f2e1cff2ee59982923f496fd07068ad4a0bb0c70aa95504a696b112dc17e08a5ab0f6698198b872f1add3987097e50e3dae482da16b34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a90b7db9c4c1a7d731af6b664014d5adcdae9aea8e4ef3b255caa8e0cb80b8eaaf9cbd8c9209ebd74f3eb6a5ea0bc6d9373fe9a14a5589dd1186e8ec061a6"}' ========= master_lag: 2.77 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-28 10:34:46.164764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 10:34:46.165181) ========= 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.pPViYfdvEU/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.skpaUYTGEF/Listeners TMPDIR=/var/folders/10/1x852mss3jl9sjlsx99svtn400000w/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.005174 ========= master_lag: 1.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 10:34:47.172643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 10:34:47.172983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 10:34:47.249269) ========= ========= Total master_lag: 7.56 =========