builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0052 starttime: 1460205496.32 results: success (0) buildid: 20160409044750 builduid: eae2e0e44c7c445b896f0389bc374538 revision: 2b18888deb3056d195d3fb4768f9c3807881deec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.320579) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.320983) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.321296) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005533 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.360466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.360752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.427375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.427640) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005485 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.478683) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.478975) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.482337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.482626) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-04-09 05:38:16-- 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% 17.1M=0.001s 2016-04-09 05:38:16 (17.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.638312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.638645) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.032037 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.688000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:16.688371) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b18888deb3056d195d3fb4768f9c3807881deec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2b18888deb3056d195d3fb4768f9c3807881deec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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-04-09 05:38:16,769 truncating revision to first 12 chars 2016-04-09 05:38:16,769 Setting DEBUG logging. 2016-04-09 05:38:16,769 attempt 1/10 2016-04-09 05:38:16,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b18888deb30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 05:38:17,396 unpacking tar archive at: mozilla-central-2b18888deb30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:17.579435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:17.579803) ========= echo 2b18888deb3056d195d3fb4768f9c3807881deec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2b18888deb3056d195d3fb4768f9c3807881deec'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 2b18888deb3056d195d3fb4768f9c3807881deec program finished with exit code 0 elapsedTime=0.005295 script_repo_revision: '2b18888deb3056d195d3fb4768f9c3807881deec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:17.636227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:17.636550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 05:38:17.659376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-09 05:38:17.659657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:17 INFO - MultiFileLogger online at 20160409 05:38:17 in /builds/slave/test 05:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:17 INFO - {'append_to_log': False, 05:38:17 INFO - 'base_work_dir': '/builds/slave/test', 05:38:17 INFO - 'blob_upload_branch': 'Firefox', 05:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:17 INFO - 'branch': 'Firefox', 05:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:17 INFO - 'config_files': ('talos/mac_config.py',), 05:38:17 INFO - 'default_actions': ('clobber', 05:38:17 INFO - 'read-buildbot-config', 05:38:17 INFO - 'download-and-extract', 05:38:17 INFO - 'populate-webroot', 05:38:17 INFO - 'create-virtualenv', 05:38:17 INFO - 'install', 05:38:17 INFO - 'run-tests'), 05:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:17 INFO - 'download_minidump_stackwalk': True, 05:38:17 INFO - 'download_symbols': 'ondemand', 05:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:17 INFO - 'installer_path': 'installer.exe', 05:38:17 INFO - 'log_level': 'info', 05:38:17 INFO - 'log_name': 'talos', 05:38:17 INFO - 'log_to_console': True, 05:38:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:38:17 INFO - 'opt_config_files': (), 05:38:17 INFO - 'pip_index': False, 05:38:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:17 INFO - 'cmd': ('bash', 05:38:17 INFO - '-c', 05:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:17 INFO - 'enabled': True, 05:38:17 INFO - 'halt_on_failure': False, 05:38:17 INFO - 'name': 'check_screen_resolution'},), 05:38:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:17 INFO - 'cmd': ('bash', 05:38:17 INFO - '-c', 05:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:17 INFO - 'enabled': True, 05:38:17 INFO - 'halt_on_failure': False, 05:38:17 INFO - 'name': 'check_screen_resolution'},), 05:38:17 INFO - 'run_cmd_checks_enabled': True, 05:38:17 INFO - 'sps_profile': False, 05:38:17 INFO - 'sps_profile_interval': 0, 05:38:17 INFO - 'suite': 'dromaeojs', 05:38:17 INFO - 'system_bits': '32', 05:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:17 INFO - 'title': 't-yosemite-r7-0052', 05:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:17 INFO - 'use_talos_json': True, 05:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:17 INFO - 'work_dir': 'build'} 05:38:17 INFO - ##### 05:38:17 INFO - ##### Running clobber step. 05:38:17 INFO - ##### 05:38:17 INFO - Running pre-action listener: _resource_record_pre_action 05:38:17 INFO - Running main action method: clobber 05:38:17 INFO - rmtree: /builds/slave/test/build 05:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:19 INFO - Running post-action listener: _resource_record_post_action 05:38:19 INFO - ##### 05:38:19 INFO - ##### Running read-buildbot-config step. 05:38:19 INFO - ##### 05:38:19 INFO - Running pre-action listener: _resource_record_pre_action 05:38:19 INFO - Running main action method: read_buildbot_config 05:38:19 INFO - Using buildbot properties: 05:38:19 INFO - { 05:38:19 INFO - "project": "", 05:38:19 INFO - "product": "firefox", 05:38:19 INFO - "script_repo_revision": "production", 05:38:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:38:19 INFO - "repository": "", 05:38:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:38:19 INFO - "buildid": "20160409044750", 05:38:19 INFO - "pgo_build": "False", 05:38:19 INFO - "basedir": "/builds/slave/test", 05:38:19 INFO - "buildnumber": 202, 05:38:19 INFO - "slavename": "t-yosemite-r7-0052", 05:38:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:38:19 INFO - "platform": "yosemite_r7", 05:38:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:38:19 INFO - "branch": "mozilla-central", 05:38:19 INFO - "repo_path": "mozilla-central", 05:38:19 INFO - "revision": "2b18888deb3056d195d3fb4768f9c3807881deec", 05:38:19 INFO - "stage_platform": "macosx64", 05:38:19 INFO - "builduid": "eae2e0e44c7c445b896f0389bc374538", 05:38:19 INFO - "slavebuilddir": "test" 05:38:19 INFO - } 05:38:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:38:19 INFO - Running post-action listener: _resource_record_post_action 05:38:19 INFO - ##### 05:38:19 INFO - ##### Running download-and-extract step. 05:38:19 INFO - ##### 05:38:19 INFO - Running pre-action listener: _resource_record_pre_action 05:38:19 INFO - Running main action method: download_and_extract 05:38:19 INFO - mkdir: /builds/slave/test/build/tests 05:38:19 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')]} 05:38:19 INFO - https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:21 INFO - Downloaded 1199 bytes. 05:38:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:38:21 INFO - Using the following test package requirements: 05:38:21 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:38:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:38:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:38:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'jsshell-mac.zip'], 05:38:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:38:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:38:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:38:21 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:38:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:38:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:38:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:38: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')]} 05:38:21 INFO - https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:23 INFO - Downloaded 18014465 bytes. 05:38:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:38:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:38:26 INFO - Return code: 0 05:38:26 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 05:38:26 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')]} 05:38:26 INFO - https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:28 INFO - Downloaded 18014465 bytes. 05:38:28 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'] 05:38:28 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 05:38:31 INFO - Return code: 0 05:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:31 INFO - https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:32 INFO - Downloaded 10841097 bytes. 05:38:32 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'] 05:38:32 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 05:38:33 INFO - Return code: 0 05:38:33 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')]} 05:38:33 INFO - https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRnxSfIuTzyqGlHpX4mVVg/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 05:38:36 INFO - Downloaded 108767860 bytes. 05:38:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:38:36 INFO - mkdir: /builds/slave/test/properties 05:38:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:38:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:38:36 INFO - Contents: 05:38:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:38:37 INFO - Running post-action listener: _resource_record_post_action 05:38:37 INFO - Running post-action listener: set_extra_try_arguments 05:38:37 INFO - ##### 05:38:37 INFO - ##### Running populate-webroot step. 05:38:37 INFO - ##### 05:38:37 INFO - Running pre-action listener: _resource_record_pre_action 05:38:37 INFO - Running main action method: populate_webroot 05:38:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:38:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:38:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:38:37 INFO - '--tppagecycles', 05:38:37 INFO - '7'], 05:38:37 INFO - 'tests': ['tsvgm']}}, 05:38:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:38:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:38:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:38:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:38:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['damp', 'tps']}, 05:38:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'tests': ['damp', 'tps']}, 05:38:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['dromaeo_dom']}, 05:38:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:38:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['a11yr', 05:38:37 INFO - 'ts_paint', 05:38:37 INFO - 'tpaint', 05:38:37 INFO - 'sessionrestore', 05:38:37 INFO - 'sessionrestore_no_auto_restore', 05:38:37 INFO - 'tabpaint']}, 05:38:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['tsvgx', 05:38:37 INFO - 'tsvgr_opacity', 05:38:37 INFO - 'tart', 05:38:37 INFO - 'tscrollx', 05:38:37 INFO - 'cart']}, 05:38:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:38:37 INFO - 'tsvgr_opacity', 05:38:37 INFO - 'tart', 05:38:37 INFO - 'tscrollx', 05:38:37 INFO - 'cart']}, 05:38:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'talos_options': ['--disable-e10s'], 05:38:37 INFO - 'tests': ['tp5o']}, 05:38:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'tests': ['tp5o']}, 05:38:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'talos_options': ['--disable-e10s', 05:38:37 INFO - '--xperf_path', 05:38:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:37 INFO - 'tests': ['tp5n']}, 05:38:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:37 INFO - 'talos_options': ['--xperf_path', 05:38:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:37 INFO - 'tests': ['tp5n']}}, 05:38:37 INFO - 'talos.zip': {'path': '', 05:38:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:38:37 INFO - Running post-action listener: _resource_record_post_action 05:38:37 INFO - ##### 05:38:37 INFO - ##### Running create-virtualenv step. 05:38:37 INFO - ##### 05:38:37 INFO - Running pre-action listener: _resource_record_pre_action 05:38:37 INFO - Running main action method: create_virtualenv 05:38:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:38:37 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 05:38:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:38:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:38:37 INFO - Using real prefix '/tools/python27' 05:38:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:38:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:38:41 INFO - Installing pip.................done. 05:38:41 INFO - Return code: 0 05:38:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:41 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:41 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 05:38:41 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 05:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:41 INFO - 'HOME': '/Users/cltbld', 05:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:41 INFO - 'LOGNAME': 'cltbld', 05:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:41 INFO - 'MOZ_NO_REMOTE': '1', 05:38:41 INFO - 'NO_EM_RESTART': '1', 05:38:41 INFO - 'PAGER': '/bin/cat', 05:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:41 INFO - 'PWD': '/builds/slave/test', 05:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:41 INFO - 'SHELL': '/bin/bash', 05:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:41 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:41 INFO - 'USER': 'cltbld', 05:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:41 INFO - 'XPC_FLAGS': '0x0', 05:38:41 INFO - 'XPC_SERVICE_NAME': '0', 05:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:41 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 05:38:41 INFO - Cleaning up... 05:38:41 INFO - Return code: 0 05:38:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:41 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:41 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 05:38:41 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 05:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:41 INFO - 'HOME': '/Users/cltbld', 05:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:41 INFO - 'LOGNAME': 'cltbld', 05:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:41 INFO - 'MOZ_NO_REMOTE': '1', 05:38:41 INFO - 'NO_EM_RESTART': '1', 05:38:41 INFO - 'PAGER': '/bin/cat', 05:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:41 INFO - 'PWD': '/builds/slave/test', 05:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:41 INFO - 'SHELL': '/bin/bash', 05:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:41 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:41 INFO - 'USER': 'cltbld', 05:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:41 INFO - 'XPC_FLAGS': '0x0', 05:38:41 INFO - 'XPC_SERVICE_NAME': '0', 05:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:41 INFO - Downloading/unpacking psutil>=0.7.1 05:38:41 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 05:38:41 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 05:38:41 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 05:38:41 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 05:38:41 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 05:38:41 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 05:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:44 INFO - Installing collected packages: psutil 05:38:44 INFO - Running setup.py install for psutil 05:38:44 INFO - building 'psutil._psutil_osx' extension 05:38:44 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 05:38:45 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 05:38:45 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 05:38:45 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 05:38:45 INFO - building 'psutil._psutil_posix' extension 05:38:45 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 05:38:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:38:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:38:45 INFO - ^ 05:38:45 INFO - 1 warning generated. 05:38:45 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 05:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:45 INFO - Successfully installed psutil 05:38:45 INFO - Cleaning up... 05:38:45 INFO - Return code: 0 05:38:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:38:45 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')]} 05:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:45 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')]} 05:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:45 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:45 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 05:38:45 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 05:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:45 INFO - 'HOME': '/Users/cltbld', 05:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:45 INFO - 'LOGNAME': 'cltbld', 05:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:45 INFO - 'MOZ_NO_REMOTE': '1', 05:38:45 INFO - 'NO_EM_RESTART': '1', 05:38:45 INFO - 'PAGER': '/bin/cat', 05:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:45 INFO - 'PWD': '/builds/slave/test', 05:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:45 INFO - 'SHELL': '/bin/bash', 05:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:45 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:45 INFO - 'USER': 'cltbld', 05:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:45 INFO - 'XPC_FLAGS': '0x0', 05:38:45 INFO - 'XPC_SERVICE_NAME': '0', 05:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:38:46 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 05:38:46 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 05:38:46 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 05:38:46 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 05:38:46 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 05:38:46 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 05:38:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:38:48 INFO - Installing collected packages: mozsystemmonitor 05:38:48 INFO - Running setup.py install for mozsystemmonitor 05:38:48 INFO - Successfully installed mozsystemmonitor 05:38:48 INFO - Cleaning up... 05:38:48 INFO - Return code: 0 05:38:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:48 INFO - 'HOME': '/Users/cltbld', 05:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:48 INFO - 'LOGNAME': 'cltbld', 05:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:48 INFO - 'MOZ_NO_REMOTE': '1', 05:38:48 INFO - 'NO_EM_RESTART': '1', 05:38:48 INFO - 'PAGER': '/bin/cat', 05:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:48 INFO - 'PWD': '/builds/slave/test', 05:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:48 INFO - 'SHELL': '/bin/bash', 05:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:48 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:48 INFO - 'USER': 'cltbld', 05:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:48 INFO - 'XPC_FLAGS': '0x0', 05:38:48 INFO - 'XPC_SERVICE_NAME': '0', 05:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:49 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 05:38:49 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 05:38:49 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 05:38:49 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 05:38:49 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 05:38:49 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 05:38:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:51 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 05:38:51 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 05:38:51 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 05:38:51 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 05:38:51 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 05:38:51 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 05:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:52 INFO - Downloading docopt-0.6.1.tar.gz 05:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:52 INFO - Running setup.py install for blobuploader 05:38:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:52 INFO - Running setup.py install for requests 05:38:53 INFO - Running setup.py install for docopt 05:38:53 INFO - Successfully installed blobuploader requests docopt 05:38:53 INFO - Cleaning up... 05:38:53 INFO - Return code: 0 05:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:53 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')]} 05:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 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')]} 05:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:53 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 05:38:53 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 05:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:53 INFO - 'HOME': '/Users/cltbld', 05:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:53 INFO - 'LOGNAME': 'cltbld', 05:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:53 INFO - 'MOZ_NO_REMOTE': '1', 05:38:53 INFO - 'NO_EM_RESTART': '1', 05:38:53 INFO - 'PAGER': '/bin/cat', 05:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:53 INFO - 'PWD': '/builds/slave/test', 05:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:53 INFO - 'SHELL': '/bin/bash', 05:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:53 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:53 INFO - 'USER': 'cltbld', 05:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:53 INFO - 'XPC_FLAGS': '0x0', 05:38:53 INFO - 'XPC_SERVICE_NAME': '0', 05:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:53 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-vuq40W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-xvjbqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-F91B9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-C3p9Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-LZiAKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-RHAa_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-j_Eacf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zwXBNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-2LYBym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-F1Hav9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:54 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Y171Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-MSQmez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-CE4FaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jYRFo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-52NCtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-97OXjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:55 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-5nm8Kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:55 INFO - Running setup.py install for manifestparser 05:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:55 INFO - Running setup.py install for mozcrash 05:38:55 INFO - Running setup.py install for mozdebug 05:38:56 INFO - Running setup.py install for mozdevice 05:38:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Running setup.py install for mozfile 05:38:56 INFO - Running setup.py install for mozhttpd 05:38:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Running setup.py install for mozinfo 05:38:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Running setup.py install for mozInstall 05:38:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:56 INFO - Running setup.py install for mozleak 05:38:56 INFO - Running setup.py install for mozlog 05:38:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Running setup.py install for moznetwork 05:38:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Running setup.py install for mozprocess 05:38:57 INFO - Running setup.py install for mozprofile 05:38:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Running setup.py install for mozrunner 05:38:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:57 INFO - Running setup.py install for mozscreenshot 05:38:57 INFO - Running setup.py install for moztest 05:38:58 INFO - Running setup.py install for mozversion 05:38:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:58 INFO - Cleaning up... 05:38:58 INFO - Return code: 0 05:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:58 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:38:58 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 05:38:58 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 05:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:38:58 INFO - 'HOME': '/Users/cltbld', 05:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:38:58 INFO - 'LOGNAME': 'cltbld', 05:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:58 INFO - 'MOZ_NO_REMOTE': '1', 05:38:58 INFO - 'NO_EM_RESTART': '1', 05:38:58 INFO - 'PAGER': '/bin/cat', 05:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:58 INFO - 'PWD': '/builds/slave/test', 05:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:38:58 INFO - 'SHELL': '/bin/bash', 05:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:38:58 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:38:58 INFO - 'USER': 'cltbld', 05:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:58 INFO - 'XPC_FLAGS': '0x0', 05:38:58 INFO - 'XPC_SERVICE_NAME': '0', 05:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:58 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-xp98a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:58 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)) 05:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:58 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-dJzWKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:58 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)) 05:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:58 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-uQ1ALu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:58 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)) 05:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:58 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-eLCE28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:58 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)) 05:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:58 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-CHJ5rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-8xiu5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-F2kWzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GJLNEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-qmGKNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-SQ6Idi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-ZDgECK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-eFgfAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-MdHkwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-v6i7SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:59 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)) 05:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:59 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-twgn70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:00 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)) 05:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:00 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-HoOEYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:00 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)) 05:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:00 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-giTRiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:00 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)) 05:39:00 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)) 05:39:00 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)) 05:39:00 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)) 05:39:00 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)) 05:39:00 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)) 05:39:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:00 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 05:39:00 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 05:39:00 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 05:39:00 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 05:39:00 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 05:39:00 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 05:39:02 INFO - Downloading blessings-1.6.tar.gz 05:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:02 INFO - Installing collected packages: blessings 05:39:02 INFO - Running setup.py install for blessings 05:39:02 INFO - Successfully installed blessings 05:39:02 INFO - Cleaning up... 05:39:03 INFO - Return code: 0 05:39:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:03 INFO - Reading from file tmpfile_stdout 05:39:03 INFO - Current package versions: 05:39:03 INFO - blessings == 1.6 05:39:03 INFO - blobuploader == 1.2.4 05:39:03 INFO - docopt == 0.6.1 05:39:03 INFO - manifestparser == 1.1 05:39:03 INFO - mozInstall == 1.12 05:39:03 INFO - mozcrash == 0.17 05:39:03 INFO - mozdebug == 0.1 05:39:03 INFO - mozdevice == 0.48 05:39:03 INFO - mozfile == 1.2 05:39:03 INFO - mozhttpd == 0.7 05:39:03 INFO - mozinfo == 0.9 05:39:03 INFO - mozleak == 0.1 05:39:03 INFO - mozlog == 3.1 05:39:03 INFO - moznetwork == 0.27 05:39:03 INFO - mozprocess == 0.22 05:39:03 INFO - mozprofile == 0.28 05:39:03 INFO - mozrunner == 6.11 05:39:03 INFO - mozscreenshot == 0.1 05:39:03 INFO - mozsystemmonitor == 0.0 05:39:03 INFO - moztest == 0.7 05:39:03 INFO - mozversion == 1.4 05:39:03 INFO - psutil == 3.1.1 05:39:03 INFO - requests == 1.2.3 05:39:03 INFO - wsgiref == 0.1.2 05:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:03 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:39:03 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 05:39:03 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 05:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:03 INFO - 'HOME': '/Users/cltbld', 05:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:03 INFO - 'LOGNAME': 'cltbld', 05:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:03 INFO - 'MOZ_NO_REMOTE': '1', 05:39:03 INFO - 'NO_EM_RESTART': '1', 05:39:03 INFO - 'PAGER': '/bin/cat', 05:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:03 INFO - 'PWD': '/builds/slave/test', 05:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:03 INFO - 'SHELL': '/bin/bash', 05:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:39:03 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:03 INFO - 'USER': 'cltbld', 05:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:03 INFO - 'XPC_FLAGS': '0x0', 05:39:03 INFO - 'XPC_SERVICE_NAME': '0', 05:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 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)) 05:39:03 INFO - Cleaning up... 05:39:03 INFO - Return code: 0 05:39:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:39: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', 'jsonschema'] in /builds/slave/test/build 05:39: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 jsonschema 05:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:03 INFO - 'HOME': '/Users/cltbld', 05:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:03 INFO - 'LOGNAME': 'cltbld', 05:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:03 INFO - 'MOZ_NO_REMOTE': '1', 05:39:03 INFO - 'NO_EM_RESTART': '1', 05:39:03 INFO - 'PAGER': '/bin/cat', 05:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:03 INFO - 'PWD': '/builds/slave/test', 05:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:03 INFO - 'SHELL': '/bin/bash', 05:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:39:03 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:03 INFO - 'USER': 'cltbld', 05:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:03 INFO - 'XPC_FLAGS': '0x0', 05:39:03 INFO - 'XPC_SERVICE_NAME': '0', 05:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:03 INFO - Downloading/unpacking jsonschema 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:06 INFO - Downloading/unpacking functools32 (from jsonschema) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:06 INFO - warning: no files found matching '*.txt' 05:39:06 INFO - no previously-included directories found matching 'build' 05:39:06 INFO - no previously-included directories found matching 'dist' 05:39:06 INFO - no previously-included directories found matching '.git*' 05:39:06 INFO - Installing collected packages: jsonschema, functools32 05:39:06 INFO - Running setup.py install for functools32 05:39:06 INFO - warning: no files found matching '*.txt' 05:39:06 INFO - no previously-included directories found matching 'build' 05:39:06 INFO - no previously-included directories found matching 'dist' 05:39:06 INFO - no previously-included directories found matching '.git*' 05:39:06 INFO - Successfully installed jsonschema functools32 05:39:06 INFO - Cleaning up... 05:39:07 INFO - Return code: 0 05:39:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:07 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 0x10ef8ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef9c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae594b3010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, '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.1IPlyhN0fB/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.NcmpQnEuch/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05:39:07 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 05:39:07 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 05:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:07 INFO - 'HOME': '/Users/cltbld', 05:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:07 INFO - 'LOGNAME': 'cltbld', 05:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:07 INFO - 'MOZ_NO_REMOTE': '1', 05:39:07 INFO - 'NO_EM_RESTART': '1', 05:39:07 INFO - 'PAGER': '/bin/cat', 05:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:07 INFO - 'PWD': '/builds/slave/test', 05:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:07 INFO - 'SHELL': '/bin/bash', 05:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:39:07 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:07 INFO - 'USER': 'cltbld', 05:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:07 INFO - 'XPC_FLAGS': '0x0', 05:39:07 INFO - 'XPC_SERVICE_NAME': '0', 05:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:07 INFO - Downloading/unpacking flake8 05:39:07 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 05:39:07 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 05:39:07 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 05:39:07 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 05:39:07 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 05:39:07 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 05:39:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:39:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:39:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:11 INFO - no previously-included directories found matching 'docs/_build' 05:39:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:39:11 INFO - Running setup.py install for pep8 05:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:11 INFO - no previously-included directories found matching 'docs/_build' 05:39:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:39:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:39:11 INFO - Cleaning up... 05:39:11 INFO - Return code: 0 05:39:11 INFO - Running post-action listener: _resource_record_post_action 05:39:11 INFO - Running post-action listener: _start_resource_monitoring 05:39:11 INFO - Starting resource monitoring. 05:39:11 INFO - ##### 05:39:11 INFO - ##### Running install step. 05:39:11 INFO - ##### 05:39:11 INFO - Running pre-action listener: _resource_record_pre_action 05:39:11 INFO - Running main action method: install 05:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:11 INFO - Reading from file tmpfile_stdout 05:39:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:11 INFO - Reading from file tmpfile_stdout 05:39:11 INFO - Output received: 05:39:11 INFO - Usage: mozinstall [options] installer 05:39:11 INFO - Options: 05:39:11 INFO - -h, --help show this help message and exit 05:39:11 INFO - -d DEST, --destination=DEST 05:39:11 INFO - Directory to install application into. [default: 05:39:11 INFO - "/builds/slave/test"] 05:39:11 INFO - --app=APP Application being installed. [default: firefox] 05:39:11 INFO - mkdir: /builds/slave/test/build/application 05:39:11 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'] 05:39:11 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 05:39:44 INFO - Reading from file tmpfile_stdout 05:39:44 INFO - Output received: 05:39:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:39:44 INFO - Running post-action listener: _resource_record_post_action 05:39:44 INFO - ##### 05:39:44 INFO - ##### Running run-tests step. 05:39:44 INFO - ##### 05:39:44 INFO - Running pre-action listener: _resource_record_pre_action 05:39:44 INFO - Running main action method: run_tests 05:39:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:44 INFO - 2016-04-09 05:39:44.833 screenresolution[1653:8384] starting screenresolution argv=screenresolution get 05:39:44 INFO - 2016-04-09 05:39:44.835 screenresolution[1653:8384] Display 0: 1600x1200x32@60 05:39:44 INFO - 2016-04-09 05:39:44.841 screenresolution[1654:8386] starting screenresolution argv=screenresolution list 05:39:44 INFO - Available Modes on Display 0 05:39:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:45 INFO - Intel Iris: 05:39:45 INFO - Chipset Model: Intel Iris 05:39:45 INFO - Type: GPU 05:39:45 INFO - Bus: Built-In 05:39:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:45 INFO - Vendor: Intel (0x8086) 05:39:45 INFO - Device ID: 0x0a2e 05:39:45 INFO - Revision ID: 0x0009 05:39:45 INFO - Displays: 05:39:45 INFO - Display: 05:39:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:45 INFO - Display Serial Number: 1600x1200 60 05:39:45 INFO - Main Display: Yes 05:39:45 INFO - Mirror: Off 05:39:45 INFO - Online: Yes 05:39:45 INFO - Rotation: Supported 05:39:45 INFO - Return code: 0 05:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:45 INFO - Python 2.7.3 05:39:45 INFO - Return code: 0 05:39:45 INFO - grabbing minidump binary from tooltool 05:39:45 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')]} 05:39:45 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 0x10ee2be00>, '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 0x10ec54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee26b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:45 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 05:39:45 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 05:39:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:45 INFO - Return code: 0 05:39:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:39:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:39:46 INFO - Return code: 0 05:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 05:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 05:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IPlyhN0fB/Render', 05:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:46 INFO - 'HOME': '/Users/cltbld', 05:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:46 INFO - 'LOGNAME': 'cltbld', 05:39:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:46 INFO - 'MOZ_NO_REMOTE': '1', 05:39:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:46 INFO - 'NO_EM_RESTART': '1', 05:39:46 INFO - 'PAGER': '/bin/cat', 05:39:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:46 INFO - 'PWD': '/builds/slave/test', 05:39:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:46 INFO - 'SHELL': '/bin/bash', 05:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NcmpQnEuch/Listeners', 05:39:46 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 05:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:46 INFO - 'USER': 'cltbld', 05:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:46 INFO - 'XPC_FLAGS': '0x0', 05:39:46 INFO - 'XPC_SERVICE_NAME': '0', 05:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 05:39:46 INFO - mozversion application_buildid: 20160409044750 05:39:46 INFO - mozversion application_changeset: 2b18888deb3056d195d3fb4768f9c3807881deec 05:39:46 INFO - mozversion application_display_name: Nightly 05:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:46 INFO - mozversion application_name: Firefox 05:39:46 INFO - mozversion application_remotingname: firefox 05:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:46 INFO - mozversion application_vendor: Mozilla 05:39:46 INFO - mozversion application_version: 48.0a1 05:39:46 INFO - mozversion platform_buildid: 20160409044750 05:39:46 INFO - mozversion platform_changeset: 2b18888deb3056d195d3fb4768f9c3807881deec 05:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:46 INFO - mozversion platform_version: 48.0a1 05:39:46 INFO - using testdate: 1460205586 05:39:46 INFO - actual date: 1460205586 05:39:46 INFO - starting webserver on 'localhost:49277' 05:39:46 INFO - SUITE-START | Running 2 tests 05:39:46 INFO - TEST-START | dromaeo_css 05:39:46 INFO - operating with platform_type : mac_ 05:39:46 INFO - Initialising browser for dromaeo_css test... 05:39:46 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp0Lmkb7/profile http://localhost:49277/getInfo.html) 05:39:48 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:39:48 INFO - PROCESS | 1672 | colorDepth:24 05:39:48 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:39:48 INFO - PROCESS | 1672 | __metrics 05:39:48 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:39:48 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:39:49 INFO - TEST-INFO | 1672: exit 0 05:39:49 INFO - Browser initialized. 05:39:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:49 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmp0Lmkb7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:01 INFO - PROCESS | 1675 | RSS: Main: 237223936 05:40:01 INFO - PROCESS | 1675 | 05:40:53 INFO - PROCESS | 1675 | 1460205653390 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] 05:43:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 05:43:04 INFO - PROCESS | 1675 | RSS: Main: 308736000 05:43:04 INFO - PROCESS | 1675 | 05:46:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 05:46:07 INFO - PROCESS | 1675 | RSS: Main: 378793984 05:46:07 INFO - PROCESS | 1675 | 05:49:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 05:49:10 INFO - PROCESS | 1675 | RSS: Main: 372867072 05:49:10 INFO - PROCESS | 1675 | 05:52:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 05:52:13 INFO - PROCESS | 1675 | RSS: Main: 334090240 05:52:13 INFO - PROCESS | 1675 | 05:55:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 05:55:16 INFO - PROCESS | 1675 | RSS: Main: 334462976 05:55:16 INFO - PROCESS | 1675 | 05:58:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 05:58:19 INFO - PROCESS | 1675 | RSS: Main: 381444096 05:58:19 INFO - PROCESS | 1675 | 05:58:19 INFO - PROCESS | 1675 | __start_tp_report 05:58:19 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:58:19 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:58:19 INFO - PROCESS | 1675 | |i|pagename|runs| 05:58:19 INFO - PROCESS | 1675 | |0;dojo.html;2809.2836326736683;3343.598768147821;3350.43042682744;3371.4100032494307;3394.321135772846;5481.616286859921;5563.165525171226;5581.497665210125;5585.441455854418;5593.8601534961645;4615.8153673853;5569.554435645149;5623.831285061445;5677.829665110054;5701.885962280762;5055.747212639371;5080.872978175556;5088.821891233789;5115.130427827278;5260.736963151827;5153.587712982952;5179.896402071956;5215.6609820361555;5219.739013049332;5222.242774797652;5076.695398276097;5099.056674515189;5173.456787037363;5186.403563590197;5222.399424066243;5116.948830511722;5143.074246635604;5170;5171.741412929338;5184.9740751296;5071.1632580624155;5079.974600127012;5106.64253502255;5122.282880396748;5135.871603209912;5348.171033489815;5472.151816468454;5472.480114389126;5475.890482190334;5561.138023606348;5958.731857066442;5961.37405572413;5966.940330596682;5970.55220858433;5978.790742324041;5921.703914804242;6009.669468179249;6065.878682426371;6085.847853803646;6100.206973093514;5631.267935168484;5657.349404818417;5715.399883012307;5748.137779333092;5765.827025189251;6252.968735156386;6271.43557079865;6297.748090076438;6298.559100862895;6304.747810087637;5176.922346164811;5915.290165180206;6132.478739307119;6146.924288249538;6162.26052873658;6150;6172.135900973867;6279.96860015697;6283.37166283368;6302.936970630327;6079.422454866781;6091.269047714302;6091.543134264859;6108.450239478469;6121.816345509642;5974.3726908674835;6113.49346767832;6133.29467111279;6143.56995010354;6145.446909778141;4797.64017698674;4825.445073816556;4849.854504364875;4850.563449289581;4891.241857512091;4308.202982448257;4333.566643335705;4345.67407444443;4355.920507181284;4363;5432.456754324615;5578.135389014709;5595.4124816894455;5600.299962504687;5661.830145095571;6116.305337585956;6148.907766383508;6223.844403889939;6224.751009959551;6232.501399887998;5639.125935480007;5649.06790379591;5652.63257888236;5657.971710141423;5660.320761508646;5218.321618189687;5346.037713211582;5350.732463376816;5350.839474815684;5369.7583608737705;6214;6267.968660156579;6271.6550589718;6290.370962903673;6298.811035668938;6224.439800417984;6255.53083518747;6255.59338643005;6270.278917924315;6271;6196.535259855619;6258.123862659322;6294.464970477561;6436.774712885027;6442.452391546771;6032.487238584594;6044.84887877789;6100.359462256577;6104.908426373697;6109.755609775737;6095.226761080279;6150.200473938359;6203.286622038343;6224.9377506224355;6227.875442491216;5898.557608179318;5906.114082887601;5907.3797251288;5915.171875937458;5950.642961422329;5782.942170578409;5804;5817.127430885401;5864.384239654775;5865.354810970875;5707.514861236841;5817.360090389969;5826.94173058264;5921.6743079131065;5924.259467566554;5956.821295361146;5995.190649262294;5998.25021872266;6003;6017.518598512021;4664.580187783115;5720.628159169641;5802.245708057925;5813.593048486566;5941.851453713692 05:58:19 INFO - PROCESS | 1675 | |1;ext.html;471.91977363848144;492.95739510934374;496.8782648251179;519.9870003249919;566.7477972302327;38857;39707.80146099273;39729.404058939064;39740.801295993515;39742.80128599356;41149.794251028776;41861.7906910465;41883.58116418835;41900.95247618811;42065.369019464735;9208.953955230214;9453.385529940566;9477.857832132524;9479.668211612596;9486.241100711926;9312.627494900196;9448.716538503855;9460.432374057544;9462.905370946306;9480.857787133198;9436.433813971184;9505.667301644444;9515.714528564155;9530.237580993538;9553;8059.274665280123;9467;9483;9490.098440648128;9499.857502137473;9165.358424910259;9306.953465232698;9310.627574896997;9313.860292095624;9321.860172097357;37924.241515169815;38242.04394890122;38275.425868611994;38301.80849095764;38463;3019.2753739102677;3201.599800024997;3559.715222782171;3679.7056235501364;3838.9232215355814;23685.407864803517;27910.302242443897;28637;29426.411471770658;29520.70479295201;2732.0574401831536;2744.1767469759193;2751.7798576113864;2774.861256937145;2807.6350074490388;462441;466067;468663;468834;471034;52740;62038.68980655158;62553;62668.68665656734;62790.68604656948;51952.740236298574;65449.34550654528;67639.66180169067;67782.66108669524;67875.66062169657;16126.516204513884;16269;16340.509784706477;16348.264328105264;16351.59121021984;11242.100631949424;11499;12643.683907902376;12709.300988445539;12734.490620375267;14786.556403307917;15025.699486010219;16398.344066237216;17061;17283.65432691339;5749.8275051748515;6563.540552161303;6621.337866213436;6684.732610695615;6719.798406047827;932.48247222792;943.0239701908629;967.5404183013012;979.5543027922279;1071.7749272652675;28227.71772282251;28279.29301767472;29014.564781528294;29055.983040593477;29083.41833163367;1009.3237530854345;1076.1821016027718;1081.9350838949688;1130.0676941523277;1141.9086473082134;14002.159870407808;14979.251037448084;15327.46353877609;15385.923070384577;15500.844991550166;610670;611016;618343;619246;620151;52378;56605;59214;59618;59649;1379.0898007315125;1402.845686974432;1438.892083093772;1440.229477229677;1461.0649184521915;24475.26574202777;25437.745622543538;28975.275618109717;29346.55980160342;29654.034601523945;47281;49539;50146;52507;53217;476947;562195;563553;563927;564709;29124;31939.041828745176;34078;40840;41301;37639;38372.61627383802;41288;43525.56474435215;43837.780811097015;33740.32519349649;34904.47643285403;36189;37055.258894822495;37314.8134259327;35519.139342009315;35832;35845.462318064725;36704;36768.81615591905;36217.81891090528;36660;37064.62935370612;37417.43873841949;37440.438393423574;26219.820108095562;31173.096793838005;31848.681513184572;32117.771481023305;32438.35123297568;23856.284311470685;24404.389890252885;24515.387115321548;24554;24585.754142458347 05:58:19 INFO - PROCESS | 1675 | |2;jquery.html;383.7927519139664;388.85223615026297;392.9390944403618;399.8580503921106;401.3938952182204;14161.596958174905;19683.901580492096;19747.21011159552;20343.49141271467;20362.083706233236;15512.84487155128;16375;19549.609007819836;19709.310174143873;20092;5218.347706536673;6115.266168059817;6175.783847565336;6184.536159788011;6195.907061394083;5461.262729531502;6096.268447786272;6143.569950103494;6157.846053848645;6161.815145545641;4227.894302642443;4493.191225579394;7518.173000969889;7998.32014278787;8001.7199398021085;7698.076230852277;7760.2239776022225;7823;7831.804204894895;7834.4907581007055;6761.695723692445;7454.776356709307;7484.401247900155;7744.341730952876;7763.107242667053;28678.426431471464;29451.852740736373;29524.26189345262;29959;30064.398712025635;2070.513429344103;2171.2617709978526;2196.176433837311;2271.9204827831113;2387.928362149138;15306.698930590914;15366.231688415646;15941.123238221893;15998;16621.50135495937;1635.9918200408922;1872.9812701872943;1910.2550005497867;1914.7989461106522;2031.8069783370704;113239.3014104789;115517.42241288823;116567.83432165654;125855.37072314671;126381.36809315986;20411.917616476763;20916.37250882476;20989.790102098785;21178.78821211799;21192.470188245108;35886.923392298275;35888.10279743027;35957.820210898775;36016.7394141209;36040;10500.527476263587;10691.358518488916;10742.731431714114;10851;10882.020618144405;8779.96336704629;8819.603117859711;8938.642454301755;9046.909530904606;9079.818403632022;8345.749627511062;9165.541722913827;9332.860007099898;9626.66306679263;9667.854982175273;2999.925001874927;3701.1857391373856;3720.813959302024;3730.3844865597416;3734.4958430612064;849.3290300662532;892.4957399069505;994.751312171957;1003.6487229469627;1009.9899001009895;19799.10904009323;20319.79680203179;20394.796052039288;20421.293451819067;20569.485762855747;916.9403988740711;922.796984663373;938.7324612485409;981.0140808487424;1020.1481762728057;10218.795624087625;10722.410267435365;10738.892611073945;10746.194035447374;10795.082417994558;631746;637057;645895;652883;653765;125661;131687;138582;140496.29751851174;141854;1000.7040882057753;1003.9247056470648;1015.263933648114;1019.6533178719122;1020.8825985011819;17700.91149544244;17790.555236119202;17833.554161145556;17983;18199.909000454914;46557.53442465532;48056.759716201195;48280.7585962068;48456.20354431292;49072.01855962932;60957.695211523656;73594.63202683952;73945.63027184829;74628;76931;7968.920310796818;8292.37807164453;8329.916700833157;8385.119562445856;8684.261837743863;7127.605735630799;12294.815577766161;12576.811347829973;12801.871981280441;13080.28058456756;11004.779904402027;11227.775444491228;11434.371109589052;11480.081593472336;11611.593594224161;10464.267501275142;10718.678439646823;10898.455077245948;10991.230613856953;11101.5559377624;11322.37726925027;11406.942965285452;11441.084713223088;11687.357195354338;11776.646700598996;7989.480683755537;8037.517748935083;8185.058718247477;8296.128906464734;8531.488110713377;10204.285700000928;11410.828837567276;11627.186096973131;11682.591109311134;11726.23779454367 05:58:19 INFO - PROCESS | 1675 | |3;mootools.html;1283.1595305075168;1599.5041537123493;1605.6226786705122;1850.1211924335942;1973.546084400588;7704.229577042293;7985.401094917883;8398;8554.230119289263;8576.614052367642;8239.83520329593;8328.791780205498;8407.495550266989;8414.91585084149;8443.282321002722;2127.7765834587376;2426.2357357432397;2452.5217582571318;2453.766892145243;2460.5570997220493;2395.796357309622;2494.3639371960217;2494.762997515233;2495.238952119603;2496.1263557754824;2402.267308470916;2410.0359856057544;2437.7196622388474;2452.104981681682;2452.3746444656676;2396.221228100874;2405.494846082325;2423.3093568333115;2432.793212576933;2437.2322718343667;2437.122635851092;2444.010175878772;2445.4742230420543;2453.3498622864954;2457.0540341968294;8511.914880851236;8519.40364174508;8558.229759321692;8577.785555361104;8587.398882078258;5089.160288552384;5351.518363347279;5352.170413585901;5371.382291036542;5372.946270537323;3233.5796346475045;3234.110619579611;3301.233839895668;3362.428387174162;3373.3927892979254;928.4661319741176;929.1730359979623;949.5584553182803;968.6658102954469;973.2846357926989;11103.888961110448;11292;11311.717207069807;11328.150388720878;11347.20569560123;4730.929036064462;4757.286407038902;4923.778429970588;5005.074061298671;5028.220625803006;8825.161609647073;8870.068642792543;8956.955215223883;8957.596908139149;8966.910330896739;5201.401838788512;5213.68717876921;5237.580993520509;5243.187305967581;5267.078261304257;4705.952940470552;4885.022995400934;4902.142125128088;4909.729964851896;4934.7285899275885;3383.3909896218424;3846.249981253629;3848.7690738555775;3929.9017524562114;3995.5205375355144;1094.9087243365134;1151.0618845640777;1208.3897631695938;1209.7882870497629;1224.2960297828783;1058.402002868377;1090.220492347975;1090.9127269818555;1239.646700690299;1368.6167872995577;7963.681452741941;7995.520268783892;8015.438919275594;8032.518048917083;8215.055268644062;1094.0153861524532;1114.9442527873573;1201.237214368882;1240.1876770715196;1254.3602762590963;6232.439080482778;6378.45783108441;6390.808275751735;6396.84007899797;6406.743730250831;9667.129958303645;10549.050585447347;10574.947125264325;10617.991290827358;10669;10402.791944161074;10518.263721539419;10526.578936842594;10562.260641755158;10579.94710026445;6329;7933.56365399897;8165.673373065129;8225.424220304521;8432.903722516034;7769.028871391076;7904.604769761374;7943.841123177389;7950.840983180188;7963.402744794048;9373.437593744124;9727.319087663796;9731.56207970629;9766.902330976884;9828.754281143028;9822.607095716092;9828.901710983084;9898.75253118649;9899.752506187402;10128.59485620567;6775.1531058617675;6859.07402500676;6905.136857892763;6919.308069193242;6930;7777.883331749915;7966.880496792669;7980.401469889665;7989.720359787612;7994.880076798969;7027.15674119109;7231.385332246818;7244.384227340735;7368.926310736824;7380.040594722652;7207;7238.23998480173;7264.091988501437;7331.4134869209265;7357.448191385774;7279;7622.656980436004;7628.923710762821;7634.656440460304;7643.121041080347;5926.585139040226;6841.657917104224;6945.965270173819;6946.2011868635755;6964.268751781193;6892.655932093194;7030.472714546532;7030.9296907030275;7043.577385356895;7049.08361912948 05:58:19 INFO - PROCESS | 1675 | |4;prototype.html;310.86632747918395;312.65451675898134;319.4824384497114;324.53915440075093;327.2505961348512;4873.951260487394;5118.334616499855;5652.7846512999695;5940.584159108864;5945.524358051356;4973.278874563186;5581.190727344543;5770.596058275912;5833.941660583393;5886;3830.4062870255157;4099.323611604097;4259.382389553512;4271.914561708764;4345.174416860794;3625.5105560749357;3750.9497340744633;4209.663226941852;4352.65067828974;4376.6498680105515;4300.871068820938;4311.124660772574;4347.891302717426;4354.475933423309;4365.192439398721;4109.630133288018;4179.498460184767;4329.480462344523;4342.826286948518;4373.671974601886;3704.685101766353;3725.9441108383394;3727.3104475671817;3735.533058367704;3736.1220113273357;5563.721813909288;5608.49523542879;5629.380768115504;5653.434656534355;5653.519450846683;4037.001684166327;4225.281702110648;4528.547145285478;4819.951800481986;4919.975400123012;5962.463378295931;6072.599344367169;6078.908816367758;6127.5404344674325;6147.2930612979635;4073.388991651246;4080.6531444827224;4087.693422993287;4102;4107.774072426016;5311.7344132793205;5356.892862142774;6256.21797275336;6257.968710156466;6471.320511346335;3344.5484859544135;4074.409210664496;4124.1133156371525;4124.422580838685;4127.277726397869;3746.894666073515;4195.098053918422;4221.746695198298;4230.767307798039;4250.06498570314;3852.6883869677968;4639.628829693616;4894.951050489521;4929.852104436873;4951.678140920829;5225.693576605849;6077.817665470043;6162.137300777895;6167.84580385494;6172.660503672251;1440.2510694439043;1457.154850186889;1458.6717988452513;1458.8541145885326;1462.4223431744401;923.9619955254717;953.6423841059602;956.8277710012264;963.9807203855884;968.8692026576463;5707.430456624462;5710.600257981984;5761.205815179635;5765.654060756368;5805.703779203443;5391.840754237857;5553.666779993213;6330.4619107375465;6346.873062538816;6366.631174297549;5506.531944784658;5609.242752228479;5692.316921969307;5711.628744131618;5743.483086522233;2594.5589249827576;3317.419451595961;3359.277755282626;3370.25854312051;3373.6626337366065;5578.023845827045;6334.3032266450655;6600.900986485207;6667.2664207674625;6670.266270710218;5244.423113457517;5749.837589325854;6188.752449902044;6249.000159974382;6407.935920640734;5214.38354110227;5545.805896793593;6010.410318403839;6412.807615771534;6725.495587830932;5816.883662326645;5984.910226346696;6247.437730604086;6427.903581446376;6457.160569125984;5091.159958606789;5294.97352513235;5533.142362933751;5932.211860425593;6332.30344662096;5562.7774889005605;6168.845778855564;6645.667716614246;6669.266380698023;6673.432758215606;3549.88781674903;3839.577646458943;3912.823922923418;4146.460960075171;4192.161567686536;6218.968905155445;6292.748290068529;6353.237611486466;6361.809145725636;6362.141110950148;5467.6719396836315;5919.549710320999;6115.938840611715;6165.383461653978;6173.38266173397;5939.673317967553;6118.663473508822;6149.323574406902;6150.969245153746;6190.907136393048;5008.724520151281;5966.582339236385;5974.581779275582;6023.397660233942;6026.397360263939;4791.880202994953;5582.106862901916;6054.455099041107;6081.939180608138;6133.417325354084;5010.473900240422;5329.790793725267;5733.369329373682;6030;6083.543734220039 05:58:19 INFO - PROCESS | 1675 | |5;yui.html;668.4618881800151;744.4464296349234;745.5638451505871;747.0661672908864;758.7496126278329;14967;15186.848131518682;15442;15453;15762.605934851634;14627.634309142277;14737.48418805342;14751.336189871454;14758.33587488563;14765.18791466469;723.9420846332281;913.1370854542444;926.4348747264163;933.8505839065751;935.1863878425779;731.6268702961474;901.6663834381288;931.7204838548442;932.8041111366588;936.2603543200863;972.3922548407245;976.1653786012963;980.2794945714894;981.2983716642599;983.6803039012314;753.2730914667318;939.628846605587;975.1613612293422;978.0073225675944;986.171615842692;720.9351158395717;721.2318880392418;723.7249845058897;724.2576359231776;724.2793420546537;15468.5359439217;15594.532164035098;15619.687606247811;15646.530604081896;15662.686746265012;12582.559610413684;12606.243625382414;12626.368681565886;12961.351932403437;13148.211107333495;8587.785305367353;10173.79652406955;10185.796284074277;10217.591296348211;10277.383356998604;3481.9303613927577;3527.770694904823;3536.2220311531423;3560.893173204782;3757.5866654667966;88831.55584222102;90996;91236;93129;93479;9486.905130948602;9701.417914924987;9704.175145112744;9711.805763884682;9954.352967057119;22838.388861263054;23008.884955575115;23011.194608188634;23116;23321.76678233196;7475.9252407476315;7563.281488258606;7590.240975902366;7673;7673.040869891263;4039.818208180639;4101.774402407897;4115.36211887158;4124.649404800565;4389.4732632083715;3456.2396272819938;3565.3047655707405;3567.6075631680496;3575.1777091269155;3580.3018411409525;605.1830029460193;617.5399327500951;618.8793185328817;625.7340630232134;633.6229943183798;545.585355130104;546.5376837732927;592.3070008090544;604.0154548086591;608.3946473259047;7977.880331795028;8035.919640803634;8069.556174410463;8137.75586732399;8226.300764434971;489.2758717098714;534.5242733966772;562.7186406796602;607.9604825686316;611.6452457574596;3613.385724426854;3784.110733977513;3798.582155962842;3918.8432462701744;4049.817758200888;94507.3295602266;95836;96168.55747163798;97154;98036.50981745188;80730;81575.5921220402;81703;81763.82361763775;83597.58201209077;60418.697906510184;66027.33972660308;70435;70828.29171708217;73380.63309683418;7415.4809163360205;7569.924300756922;7579.204183560647;7846.372290216883;7907.130215676386;34857;43594.78202608967;44780;44983.77508112438;46114.38599648996;62326.441838952574;64207.67896160489;64678.676606618545;64744.70510589856;65307.346926532024;10401.583936642752;10416.739581510523;10462.21533384984;10581.52383142745;10782.353058816496;11063.22557421005;11230.438478075901;12055.758884822078;12087.51649934028;12189.390530473618;10977;11065.391403472886;11072.778544429228;11389.601363952223;11541.019013383957;10799.892001079888;11033.558657653604;11149.331040137618;11182.049525790399;12145.757084858076;10811.891881081088;11001.284916480403;11101.38942358178;11177.776444471228;11272.098232141572;9565.90434095678;9581.233501320017;9824.901750982684;9972.351797133164;9989.950050249703;9333.766655833659;9338.95330523343;9390.624375024923;9433.151016408556;9434.95282523583 05:58:19 INFO - PROCESS | 1675 | __end_tp_report 05:58:19 INFO - PROCESS | 1675 | __start_cc_report 05:58:19 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1661 05:58:19 INFO - PROCESS | 1675 | __end_cc_report 05:58:19 INFO - PROCESS | 1675 | __startTimestamp1460206699982__endTimestamp 05:58:19 INFO - PROCESS | 1675 | 05:58:19 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:58:19 INFO - PROCESS | 1675 | Number of tests: 6 05:58:19 INFO - PROCESS | 1675 | 05:58:19 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5635.94 Median:5813.59 stddev:651.30 (11.2%) stddev-sans-first:614.39 05:58:19 INFO - PROCESS | 1675 | Values: 2809.3 3343.6 3350.4 3371.4 3394.3 5481.6 5563.2 5581.5 5585.4 5593.9 4615.8 5569.6 5623.8 5677.8 5701.9 5055.7 5080.9 5088.8 5115.1 5260.7 5153.6 5179.9 5215.7 5219.7 5222.2 5076.7 5099.1 5173.5 5186.4 5222.4 5116.9 5143.1 5170.0 5171.7 5185.0 5071.2 5080.0 5106.6 5122.3 5135.9 5348.2 5472.2 5472.5 5475.9 5561.1 5958.7 5961.4 5966.9 5970.6 5978.8 5921.7 6009.7 6065.9 6085.8 6100.2 5631.3 5657.3 5715.4 5748.1 5765.8 6253.0 6271.4 6297.7 6298.6 6304.7 5176.9 5915.3 6132.5 6146.9 6162.3 6150.0 6172.1 6280.0 6283.4 6302.9 6079.4 6091.3 6091.5 6108.5 6121.8 5974.4 6113.5 6133.3 6143.6 6145.4 4797.6 4825.4 4849.9 4850.6 4891.2 4308.2 4333.6 4345.7 4355.9 4363.0 5432.5 5578.1 5595.4 5600.3 5661.8 6116.3 6148.9 6223.8 6224.8 6232.5 5639.1 5649.1 5652.6 5658.0 5660.3 5218.3 5346.0 5350.7 5350.8 5369.8 6214.0 6268.0 6271.7 6290.4 6298.8 6224.4 6255.5 6255.6 6270.3 6271.0 6196.5 6258.1 6294.5 6436.8 6442.5 6032.5 6044.8 6100.4 6104.9 6109.8 6095.2 6150.2 6203.3 6224.9 6227.9 5898.6 5906.1 5907.4 5915.2 5950.6 5782.9 5804.0 5817.1 5864.4 5865.4 5707.5 5817.4 5826.9 5921.7 5924.3 5956.8 5995.2 5998.3 6003.0 6017.5 4664.6 5720.6 5802.2 5813.6 5941.9 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:67489.16 Median:38660.00 stddev:146101.06 (377.9%) stddev-sans-first:146424.26 05:58:20 INFO - PROCESS | 1675 | Values: 471.9 493.0 496.9 520.0 566.7 38857.0 39707.8 39729.4 39740.8 39742.8 41149.8 41861.8 41883.6 41901.0 42065.4 9209.0 9453.4 9477.9 9479.7 9486.2 9312.6 9448.7 9460.4 9462.9 9480.9 9436.4 9505.7 9515.7 9530.2 9553.0 8059.3 9467.0 9483.0 9490.1 9499.9 9165.4 9307.0 9310.6 9313.9 9321.9 37924.2 38242.0 38275.4 38301.8 38463.0 3019.3 3201.6 3559.7 3679.7 3838.9 23685.4 27910.3 28637.0 29426.4 29520.7 2732.1 2744.2 2751.8 2774.9 2807.6 462441.0 466067.0 468663.0 468834.0 471034.0 52740.0 62038.7 62553.0 62668.7 62790.7 51952.7 65449.3 67639.7 67782.7 67875.7 16126.5 16269.0 16340.5 16348.3 16351.6 11242.1 11499.0 12643.7 12709.3 12734.5 14786.6 15025.7 16398.3 17061.0 17283.7 5749.8 6563.5 6621.3 6684.7 6719.8 932.5 943.0 967.5 979.6 1071.8 28227.7 28279.3 29014.6 29056.0 29083.4 1009.3 1076.2 1081.9 1130.1 1141.9 14002.2 14979.3 15327.5 15385.9 15500.8 610670.0 611016.0 618343.0 619246.0 620151.0 52378.0 56605.0 59214.0 59618.0 59649.0 1379.1 1402.8 1438.9 1440.2 1461.1 24475.3 25437.7 28975.3 29346.6 29654.0 47281.0 49539.0 50146.0 52507.0 53217.0 476947.0 562195.0 563553.0 563927.0 564709.0 29124.0 31939.0 34078.0 40840.0 41301.0 37639.0 38372.6 41288.0 43525.6 43837.8 33740.3 34904.5 36189.0 37055.3 37314.8 35519.1 35832.0 35845.5 36704.0 36768.8 36217.8 36660.0 37064.6 37417.4 37440.4 26219.8 31173.1 31848.7 32117.8 32438.4 23856.3 24404.4 24515.4 24554.0 24585.8 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:37623.96 Median:2329.92 stddev:107042.78 (4594.3%) stddev-sans-first:107306.54 05:58:20 INFO - PROCESS | 1675 | Values: 383.8 388.9 392.9 399.9 401.4 14161.6 19683.9 19747.2 20343.5 20362.1 15512.8 16375.0 19549.6 19709.3 20092.0 5218.3 6115.3 6175.8 6184.5 6195.9 5461.3 6096.3 6143.6 6157.8 6161.8 4227.9 4493.2 7518.2 7998.3 8001.7 7698.1 7760.2 7823.0 7831.8 7834.5 6761.7 7454.8 7484.4 7744.3 7763.1 28678.4 29451.9 29524.3 29959.0 30064.4 2070.5 2171.3 2196.2 2271.9 2387.9 15306.7 15366.2 15941.1 15998.0 16621.5 1636.0 1873.0 1910.3 1914.8 2031.8 113239.3 115517.4 116567.8 125855.4 126381.4 20411.9 20916.4 20989.8 21178.8 21192.5 35886.9 35888.1 35957.8 36016.7 36040.0 10500.5 10691.4 10742.7 10851.0 10882.0 8780.0 8819.6 8938.6 9046.9 9079.8 8345.7 9165.5 9332.9 9626.7 9667.9 2999.9 3701.2 3720.8 3730.4 3734.5 849.3 892.5 994.8 1003.6 1010.0 19799.1 20319.8 20394.8 20421.3 20569.5 916.9 922.8 938.7 981.0 1020.1 10218.8 10722.4 10738.9 10746.2 10795.1 631746.0 637057.0 645895.0 652883.0 653765.0 125661.0 131687.0 138582.0 140496.3 141854.0 1000.7 1003.9 1015.3 1019.7 1020.9 17700.9 17790.6 17833.6 17983.0 18199.9 46557.5 48056.8 48280.8 48456.2 49072.0 60957.7 73594.6 73945.6 74628.0 76931.0 7968.9 8292.4 8329.9 8385.1 8684.3 7127.6 12294.8 12576.8 12801.9 13080.3 11004.8 11227.8 11434.4 11480.1 11611.6 10464.3 10718.7 10898.5 10991.2 11101.6 11322.4 11406.9 11441.1 11687.4 11776.6 7989.5 8037.5 8185.1 8296.1 8531.5 10204.3 11410.8 11627.2 11682.6 11726.2 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5898.85 Median:6079.51 stddev:3080.59 (50.7%) stddev-sans-first:3069.69 05:58:20 INFO - PROCESS | 1675 | Values: 1283.2 1599.5 1605.6 1850.1 1973.5 7704.2 7985.4 8398.0 8554.2 8576.6 8239.8 8328.8 8407.5 8414.9 8443.3 2127.8 2426.2 2452.5 2453.8 2460.6 2395.8 2494.4 2494.8 2495.2 2496.1 2402.3 2410.0 2437.7 2452.1 2452.4 2396.2 2405.5 2423.3 2432.8 2437.2 2437.1 2444.0 2445.5 2453.3 2457.1 8511.9 8519.4 8558.2 8577.8 8587.4 5089.2 5351.5 5352.2 5371.4 5372.9 3233.6 3234.1 3301.2 3362.4 3373.4 928.5 929.2 949.6 968.7 973.3 11103.9 11292.0 11311.7 11328.2 11347.2 4730.9 4757.3 4923.8 5005.1 5028.2 8825.2 8870.1 8957.0 8957.6 8966.9 5201.4 5213.7 5237.6 5243.2 5267.1 4706.0 4885.0 4902.1 4909.7 4934.7 3383.4 3846.2 3848.8 3929.9 3995.5 1094.9 1151.1 1208.4 1209.8 1224.3 1058.4 1090.2 1090.9 1239.6 1368.6 7963.7 7995.5 8015.4 8032.5 8215.1 1094.0 1114.9 1201.2 1240.2 1254.4 6232.4 6378.5 6390.8 6396.8 6406.7 9667.1 10549.1 10574.9 10618.0 10669.0 10402.8 10518.3 10526.6 10562.3 10579.9 6329.0 7933.6 8165.7 8225.4 8432.9 7769.0 7904.6 7943.8 7950.8 7963.4 9373.4 9727.3 9731.6 9766.9 9828.8 9822.6 9828.9 9898.8 9899.8 10128.6 6775.2 6859.1 6905.1 6919.3 6930.0 7777.9 7966.9 7980.4 7989.7 7994.9 7027.2 7231.4 7244.4 7368.9 7380.0 7207.0 7238.2 7264.1 7331.4 7357.4 7279.0 7622.7 7628.9 7634.7 7643.1 5926.6 6841.7 6946.0 6946.2 6964.3 6892.7 7030.5 7030.9 7043.6 7049.1 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4886.32 Median:5563.25 stddev:1533.40 (27.6%) stddev-sans-first:1498.76 05:58:20 INFO - PROCESS | 1675 | Values: 310.9 312.7 319.5 324.5 327.3 4874.0 5118.3 5652.8 5940.6 5945.5 4973.3 5581.2 5770.6 5833.9 5886.0 3830.4 4099.3 4259.4 4271.9 4345.2 3625.5 3750.9 4209.7 4352.7 4376.6 4300.9 4311.1 4347.9 4354.5 4365.2 4109.6 4179.5 4329.5 4342.8 4373.7 3704.7 3725.9 3727.3 3735.5 3736.1 5563.7 5608.5 5629.4 5653.4 5653.5 4037.0 4225.3 4528.5 4820.0 4920.0 5962.5 6072.6 6078.9 6127.5 6147.3 4073.4 4080.7 4087.7 4102.0 4107.8 5311.7 5356.9 6256.2 6258.0 6471.3 3344.5 4074.4 4124.1 4124.4 4127.3 3746.9 4195.1 4221.7 4230.8 4250.1 3852.7 4639.6 4895.0 4929.9 4951.7 5225.7 6077.8 6162.1 6167.8 6172.7 1440.3 1457.2 1458.7 1458.9 1462.4 924.0 953.6 956.8 964.0 968.9 5707.4 5710.6 5761.2 5765.7 5805.7 5391.8 5553.7 6330.5 6346.9 6366.6 5506.5 5609.2 5692.3 5711.6 5743.5 2594.6 3317.4 3359.3 3370.3 3373.7 5578.0 6334.3 6600.9 6667.3 6670.3 5244.4 5749.8 6188.8 6249.0 6407.9 5214.4 5545.8 6010.4 6412.8 6725.5 5816.9 5984.9 6247.4 6427.9 6457.2 5091.2 5295.0 5533.1 5932.2 6332.3 5562.8 6168.8 6645.7 6669.3 6673.4 3549.9 3839.6 3912.8 4146.5 4192.2 6219.0 6292.7 6353.2 6361.8 6362.1 5467.7 5919.5 6115.9 6165.4 6173.4 5939.7 6118.7 6149.3 6151.0 6190.9 5008.7 5966.6 5974.6 6023.4 6026.4 4791.9 5582.1 6054.5 6081.9 6133.4 5010.5 5329.8 5733.4 6030.0 6083.5 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18515.07 Median:614.59 stddev:26595.63 (4327.4%) stddev-sans-first:26636.48 05:58:20 INFO - PROCESS | 1675 | Values: 668.5 744.4 745.6 747.1 758.7 14967.0 15186.8 15442.0 15453.0 15762.6 14627.6 14737.5 14751.3 14758.3 14765.2 723.9 913.1 926.4 933.9 935.2 731.6 901.7 931.7 932.8 936.3 972.4 976.2 980.3 981.3 983.7 753.3 939.6 975.2 978.0 986.2 720.9 721.2 723.7 724.3 724.3 15468.5 15594.5 15619.7 15646.5 15662.7 12582.6 12606.2 12626.4 12961.4 13148.2 8587.8 10173.8 10185.8 10217.6 10277.4 3481.9 3527.8 3536.2 3560.9 3757.6 88831.6 90996.0 91236.0 93129.0 93479.0 9486.9 9701.4 9704.2 9711.8 9954.4 22838.4 23008.9 23011.2 23116.0 23321.8 7475.9 7563.3 7590.2 7673.0 7673.0 4039.8 4101.8 4115.4 4124.6 4389.5 3456.2 3565.3 3567.6 3575.2 3580.3 605.2 617.5 618.9 625.7 633.6 545.6 546.5 592.3 604.0 608.4 7977.9 8035.9 8069.6 8137.8 8226.3 489.3 534.5 562.7 608.0 611.6 3613.4 3784.1 3798.6 3918.8 4049.8 94507.3 95836.0 96168.6 97154.0 98036.5 80730.0 81575.6 81703.0 81763.8 83597.6 60418.7 66027.3 70435.0 70828.3 73380.6 7415.5 7569.9 7579.2 7846.4 7907.1 34857.0 43594.8 44780.0 44983.8 46114.4 62326.4 64207.7 64678.7 64744.7 65307.3 10401.6 10416.7 10462.2 10581.5 10782.4 11063.2 11230.4 12055.8 12087.5 12189.4 10977.0 11065.4 11072.8 11389.6 11541.0 10799.9 11033.6 11149.3 11182.0 12145.8 10811.9 11001.3 11101.4 11177.8 11272.1 9565.9 9581.2 9824.9 9972.4 9990.0 9333.8 9339.0 9390.6 9433.2 9435.0 05:58:20 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:58:20 INFO - PROCESS | 1675 | 05:58:20 INFO - TEST-INFO | 1675: exit 0 05:58:20 INFO - TEST-OK | dromaeo_css | took 1113952ms 05:58:20 INFO - TEST-START | kraken 05:58:20 INFO - operating with platform_type : mac_ 05:58:20 INFO - Initialising browser for kraken test... 05:58:20 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpJ1f9KA/profile http://localhost:49277/getInfo.html) 05:58:22 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 05:58:22 INFO - PROCESS | 1681 | colorDepth:24 05:58:22 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 05:58:22 INFO - PROCESS | 1681 | __metrics 05:58:22 INFO - PROCESS | 1681 | 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" 05:58:22 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:58:23 INFO - TEST-INFO | 1681: exit 0 05:58:23 INFO - Browser initialized. 05:58:23 INFO - Running cycle 1/1 for kraken test... 05:58:23 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpJ1f9KA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:35 INFO - PROCESS | 1683 | RSS: Main: 237293568 05:58:35 INFO - PROCESS | 1683 | 05:58:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:38 INFO - PROCESS | 1683 | RSS: Main: 283709440 05:58:38 INFO - PROCESS | 1683 | 05:58:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 05:58:41 INFO - PROCESS | 1683 | RSS: Main: 294400000 05:58:41 INFO - PROCESS | 1683 | 05:58:45 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 05:58:45 INFO - PROCESS | 1683 | RSS: Main: 279457792 05:58:45 INFO - PROCESS | 1683 | 05:58:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 05:58:48 INFO - PROCESS | 1683 | RSS: Main: 282357760 05:58:48 INFO - PROCESS | 1683 | 05:58:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:50 INFO - PROCESS | 1683 | RSS: Main: 283439104 05:58:50 INFO - PROCESS | 1683 | 05:58:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:54 INFO - PROCESS | 1683 | RSS: Main: 283447296 05:58:54 INFO - PROCESS | 1683 | 05:58:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:57 INFO - PROCESS | 1683 | RSS: Main: 283783168 05:58:57 INFO - PROCESS | 1683 | 05:59:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 05:59:01 INFO - PROCESS | 1683 | RSS: Main: 284209152 05:59:01 INFO - PROCESS | 1683 | 05:59:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:03 INFO - PROCESS | 1683 | RSS: Main: 317661184 05:59:03 INFO - PROCESS | 1683 | 05:59:05 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:05 INFO - PROCESS | 1683 | RSS: Main: 317087744 05:59:05 INFO - PROCESS | 1683 | 05:59:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:08 INFO - PROCESS | 1683 | RSS: Main: 325586944 05:59:08 INFO - PROCESS | 1683 | 05:59:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:11 INFO - PROCESS | 1683 | RSS: Main: 326799360 05:59:11 INFO - PROCESS | 1683 | 05:59:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:15 INFO - PROCESS | 1683 | RSS: Main: 326918144 05:59:15 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 05:59:17 INFO - PROCESS | 1683 | RSS: Main: 390942720 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | __start_tp_report 05:59:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 05:59:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 05:59:17 INFO - PROCESS | 1683 | |i|pagename|runs| 05:59:17 INFO - PROCESS | 1683 | |0;ai-astar;113;109;113;113;114;114;120;114;114;112 05:59:17 INFO - PROCESS | 1683 | |1;audio-beat-detection;184;120;144;161;123;141;145;121;162;121 05:59:17 INFO - PROCESS | 1683 | |2;audio-dft;184;185;187;185;182;184;184;182;185;179 05:59:17 INFO - PROCESS | 1683 | |3;audio-fft;77;74;86;79;56;58;57;77;80;56 05:59:17 INFO - PROCESS | 1683 | |4;audio-oscillator;103;93;129;78;79;76;119;80;76;119 05:59:17 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;88;86;88;86;88;85;90;86;88;86 05:59:17 INFO - PROCESS | 1683 | |6;imaging-darkroom;94;94;93;106;148;107;93;95;94;94 05:59:17 INFO - PROCESS | 1683 | |7;imaging-desaturate;86;85;85;85;86;86;85;88;85;84 05:59:17 INFO - PROCESS | 1683 | |8;json-parse-financial;56;53;53;53;54;53;55;65;53;53 05:59:17 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;64;72;64;74;71;67;68;69;68;69 05:59:17 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;86;102;71;85;100;111;111;109;87;86 05:59:17 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;145;146;144;138;141;142;142;141;141;145 05:59:17 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;172;172;170;170;171;174;169;171;169;169 05:59:17 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;70;71;69;70;68;68;68;69;70;70 05:59:17 INFO - PROCESS | 1683 | __end_tp_report 05:59:17 INFO - PROCESS | 1683 | __start_cc_report 05:59:17 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1324 05:59:17 INFO - PROCESS | 1683 | __end_cc_report 05:59:17 INFO - PROCESS | 1683 | __startTimestamp1460206757428__endTimestamp 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | ------- Summary: start ------- 05:59:17 INFO - PROCESS | 1683 | Number of tests: 14 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:2.72 (2.4%) stddev-sans-first:2.87 05:59:17 INFO - PROCESS | 1683 | Values: 113.0 109.0 113.0 113.0 114.0 114.0 120.0 114.0 114.0 112.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:144.50 stddev:21.77 (15.1%) stddev-sans-first:17.04 05:59:17 INFO - PROCESS | 1683 | Values: 184.0 120.0 144.0 161.0 123.0 141.0 145.0 121.0 162.0 121.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.21 (1.2%) stddev-sans-first:2.35 05:59:17 INFO - PROCESS | 1683 | Values: 184.0 185.0 187.0 185.0 182.0 184.0 184.0 182.0 185.0 179.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.00 stddev:11.81 (15.3%) stddev-sans-first:12.26 05:59:17 INFO - PROCESS | 1683 | Values: 77.0 74.0 86.0 79.0 56.0 58.0 57.0 77.0 80.0 56.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:77.00 stddev:20.73 (26.9%) stddev-sans-first:21.79 05:59:17 INFO - PROCESS | 1683 | Values: 103.0 93.0 129.0 78.0 79.0 76.0 119.0 80.0 76.0 119.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.52 (1.7%) stddev-sans-first:1.58 05:59:17 INFO - PROCESS | 1683 | Values: 88.0 86.0 88.0 86.0 88.0 85.0 90.0 86.0 88.0 86.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:94.00 stddev:17.07 (18.2%) stddev-sans-first:17.87 05:59:17 INFO - PROCESS | 1683 | Values: 94.0 94.0 93.0 106.0 148.0 107.0 93.0 95.0 94.0 94.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 05:59:17 INFO - PROCESS | 1683 | Values: 86.0 85.0 85.0 85.0 86.0 86.0 85.0 88.0 85.0 84.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:53.50 stddev:3.74 (7.0%) stddev-sans-first:3.94 05:59:17 INFO - PROCESS | 1683 | Values: 56.0 53.0 53.0 53.0 54.0 53.0 55.0 65.0 53.0 53.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:2.93 05:59:17 INFO - PROCESS | 1683 | Values: 64.0 72.0 64.0 74.0 71.0 67.0 68.0 69.0 68.0 69.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:78.00 stddev:13.68 (17.5%) stddev-sans-first:14.13 05:59:17 INFO - PROCESS | 1683 | Values: 86.0 102.0 71.0 85.0 100.0 111.0 111.0 109.0 87.0 86.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:143.00 stddev:2.46 (1.7%) stddev-sans-first:2.44 05:59:17 INFO - PROCESS | 1683 | Values: 145.0 146.0 144.0 138.0 141.0 142.0 142.0 141.0 141.0 145.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 05:59:17 INFO - PROCESS | 1683 | Values: 172.0 172.0 170.0 170.0 171.0 174.0 169.0 171.0 169.0 169.0 05:59:17 INFO - PROCESS | 1683 | 05:59:17 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 05:59:17 INFO - PROCESS | 1683 | Values: 70.0 71.0 69.0 70.0 68.0 68.0 68.0 69.0 70.0 70.0 05:59:17 INFO - PROCESS | 1683 | -------- Summary: end -------- 05:59:17 INFO - PROCESS | 1683 | 05:59:18 INFO - TEST-INFO | 1683: exit 0 05:59:18 INFO - TEST-OK | kraken | took 57798ms 05:59:18 INFO - SUITE-END | took 1171s 05:59:18 INFO - Completed test suite (00:19:32) 05:59:18 INFO - javascript benchmark 05:59:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2809.2836326736683, 3343.598768147821, 3350.43042682744, 3371.4100032494307, 3394.321135772846, 5481.616286859921, 5563.165525171226, 5581.497665210125, 5585.441455854418, 5593.8601534961645, 4615.8153673853, 5569.554435645149, 5623.831285061445, 5677.829665110054, 5701.885962280762, 5055.747212639371, 5080.872978175556, 5088.821891233789, 5115.130427827278, 5260.736963151827, 5153.587712982952, 5179.896402071956, 5215.6609820361555, 5219.739013049332, 5222.242774797652, 5076.695398276097, 5099.056674515189, 5173.456787037363, 5186.403563590197, 5222.399424066243, 5116.948830511722, 5143.074246635604, 5170.0, 5171.741412929338, 5184.9740751296, 5071.1632580624155, 5079.974600127012, 5106.64253502255, 5122.282880396748, 5135.871603209912, 5348.171033489815, 5472.151816468454, 5472.480114389126, 5475.890482190334, 5561.138023606348, 5958.731857066442, 5961.37405572413, 5966.940330596682, 5970.55220858433, 5978.790742324041, 5921.703914804242, 6009.669468179249, 6065.878682426371, 6085.847853803646, 6100.206973093514, 5631.267935168484, 5657.349404818417, 5715.399883012307, 5748.137779333092, 5765.827025189251, 6252.968735156386, 6271.43557079865, 6297.748090076438, 6298.559100862895, 6304.747810087637, 5176.922346164811, 5915.290165180206, 6132.478739307119, 6146.924288249538, 6162.26052873658, 6150.0, 6172.135900973867, 6279.96860015697, 6283.37166283368, 6302.936970630327, 6079.422454866781, 6091.269047714302, 6091.543134264859, 6108.450239478469, 6121.816345509642, 5974.3726908674835, 6113.49346767832, 6133.29467111279, 6143.56995010354, 6145.446909778141, 4797.64017698674, 4825.445073816556, 4849.854504364875, 4850.563449289581, 4891.241857512091, 4308.202982448257, 4333.566643335705, 4345.67407444443, 4355.920507181284, 4363.0, 5432.456754324615, 5578.135389014709, 5595.4124816894455, 5600.299962504687, 5661.830145095571, 6116.305337585956, 6148.907766383508, 6223.844403889939, 6224.751009959551, 6232.501399887998, 5639.125935480007, 5649.06790379591, 5652.63257888236, 5657.971710141423, 5660.320761508646, 5218.321618189687, 5346.037713211582, 5350.732463376816, 5350.839474815684, 5369.7583608737705, 6214.0, 6267.968660156579, 6271.6550589718, 6290.370962903673, 6298.811035668938, 6224.439800417984, 6255.53083518747, 6255.59338643005, 6270.278917924315, 6271.0, 6196.535259855619, 6258.123862659322, 6294.464970477561, 6436.774712885027, 6442.452391546771, 6032.487238584594, 6044.84887877789, 6100.359462256577, 6104.908426373697, 6109.755609775737, 6095.226761080279, 6150.200473938359, 6203.286622038343, 6224.9377506224355, 6227.875442491216, 5898.557608179318, 5906.114082887601, 5907.3797251288, 5915.171875937458, 5950.642961422329, 5782.942170578409, 5804.0, 5817.127430885401, 5864.384239654775, 5865.354810970875, 5707.514861236841, 5817.360090389969, 5826.94173058264, 5921.6743079131065, 5924.259467566554, 5956.821295361146, 5995.190649262294, 5998.25021872266, 6003.0, 6017.518598512021, 4664.580187783115, 5720.628159169641, 5802.245708057925, 5813.593048486566, 5941.851453713692], "value": 5593.468764653879, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.91977363848144, 492.95739510934374, 496.8782648251179, 519.9870003249919, 566.7477972302327, 38857.0, 39707.80146099273, 39729.404058939064, 39740.801295993515, 39742.80128599356, 41149.794251028776, 41861.7906910465, 41883.58116418835, 41900.95247618811, 42065.369019464735, 9208.953955230214, 9453.385529940566, 9477.857832132524, 9479.668211612596, 9486.241100711926, 9312.627494900196, 9448.716538503855, 9460.432374057544, 9462.905370946306, 9480.857787133198, 9436.433813971184, 9505.667301644444, 9515.714528564155, 9530.237580993538, 9553.0, 8059.274665280123, 9467.0, 9483.0, 9490.098440648128, 9499.857502137473, 9165.358424910259, 9306.953465232698, 9310.627574896997, 9313.860292095624, 9321.860172097357, 37924.241515169815, 38242.04394890122, 38275.425868611994, 38301.80849095764, 38463.0, 3019.2753739102677, 3201.599800024997, 3559.715222782171, 3679.7056235501364, 3838.9232215355814, 23685.407864803517, 27910.302242443897, 28637.0, 29426.411471770658, 29520.70479295201, 2732.0574401831536, 2744.1767469759193, 2751.7798576113864, 2774.861256937145, 2807.6350074490388, 462441.0, 466067.0, 468663.0, 468834.0, 471034.0, 52740.0, 62038.68980655158, 62553.0, 62668.68665656734, 62790.68604656948, 51952.740236298574, 65449.34550654528, 67639.66180169067, 67782.66108669524, 67875.66062169657, 16126.516204513884, 16269.0, 16340.509784706477, 16348.264328105264, 16351.59121021984, 11242.100631949424, 11499.0, 12643.683907902376, 12709.300988445539, 12734.490620375267, 14786.556403307917, 15025.699486010219, 16398.344066237216, 17061.0, 17283.65432691339, 5749.8275051748515, 6563.540552161303, 6621.337866213436, 6684.732610695615, 6719.798406047827, 932.48247222792, 943.0239701908629, 967.5404183013012, 979.5543027922279, 1071.7749272652675, 28227.71772282251, 28279.29301767472, 29014.564781528294, 29055.983040593477, 29083.41833163367, 1009.3237530854345, 1076.1821016027718, 1081.9350838949688, 1130.0676941523277, 1141.9086473082134, 14002.159870407808, 14979.251037448084, 15327.46353877609, 15385.923070384577, 15500.844991550166, 610670.0, 611016.0, 618343.0, 619246.0, 620151.0, 52378.0, 56605.0, 59214.0, 59618.0, 59649.0, 1379.0898007315125, 1402.845686974432, 1438.892083093772, 1440.229477229677, 1461.0649184521915, 24475.26574202777, 25437.745622543538, 28975.275618109717, 29346.55980160342, 29654.034601523945, 47281.0, 49539.0, 50146.0, 52507.0, 53217.0, 476947.0, 562195.0, 563553.0, 563927.0, 564709.0, 29124.0, 31939.041828745176, 34078.0, 40840.0, 41301.0, 37639.0, 38372.61627383802, 41288.0, 43525.56474435215, 43837.780811097015, 33740.32519349649, 34904.47643285403, 36189.0, 37055.258894822495, 37314.8134259327, 35519.139342009315, 35832.0, 35845.462318064725, 36704.0, 36768.81615591905, 36217.81891090528, 36660.0, 37064.62935370612, 37417.43873841949, 37440.438393423574, 26219.820108095562, 31173.096793838005, 31848.681513184572, 32117.771481023305, 32438.35123297568, 23856.284311470685, 24404.389890252885, 24515.387115321548, 24554.0, 24585.754142458347], "value": 19363.30387110715, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.7927519139664, 388.85223615026297, 392.9390944403618, 399.8580503921106, 401.3938952182204, 14161.596958174905, 19683.901580492096, 19747.21011159552, 20343.49141271467, 20362.083706233236, 15512.84487155128, 16375.0, 19549.609007819836, 19709.310174143873, 20092.0, 5218.347706536673, 6115.266168059817, 6175.783847565336, 6184.536159788011, 6195.907061394083, 5461.262729531502, 6096.268447786272, 6143.569950103494, 6157.846053848645, 6161.815145545641, 4227.894302642443, 4493.191225579394, 7518.173000969889, 7998.32014278787, 8001.7199398021085, 7698.076230852277, 7760.2239776022225, 7823.0, 7831.804204894895, 7834.4907581007055, 6761.695723692445, 7454.776356709307, 7484.401247900155, 7744.341730952876, 7763.107242667053, 28678.426431471464, 29451.852740736373, 29524.26189345262, 29959.0, 30064.398712025635, 2070.513429344103, 2171.2617709978526, 2196.176433837311, 2271.9204827831113, 2387.928362149138, 15306.698930590914, 15366.231688415646, 15941.123238221893, 15998.0, 16621.50135495937, 1635.9918200408922, 1872.9812701872943, 1910.2550005497867, 1914.7989461106522, 2031.8069783370704, 113239.3014104789, 115517.42241288823, 116567.83432165654, 125855.37072314671, 126381.36809315986, 20411.917616476763, 20916.37250882476, 20989.790102098785, 21178.78821211799, 21192.470188245108, 35886.923392298275, 35888.10279743027, 35957.820210898775, 36016.7394141209, 36040.0, 10500.527476263587, 10691.358518488916, 10742.731431714114, 10851.0, 10882.020618144405, 8779.96336704629, 8819.603117859711, 8938.642454301755, 9046.909530904606, 9079.818403632022, 8345.749627511062, 9165.541722913827, 9332.860007099898, 9626.66306679263, 9667.854982175273, 2999.925001874927, 3701.1857391373856, 3720.813959302024, 3730.3844865597416, 3734.4958430612064, 849.3290300662532, 892.4957399069505, 994.751312171957, 1003.6487229469627, 1009.9899001009895, 19799.10904009323, 20319.79680203179, 20394.796052039288, 20421.293451819067, 20569.485762855747, 916.9403988740711, 922.796984663373, 938.7324612485409, 981.0140808487424, 1020.1481762728057, 10218.795624087625, 10722.410267435365, 10738.892611073945, 10746.194035447374, 10795.082417994558, 631746.0, 637057.0, 645895.0, 652883.0, 653765.0, 125661.0, 131687.0, 138582.0, 140496.29751851174, 141854.0, 1000.7040882057753, 1003.9247056470648, 1015.263933648114, 1019.6533178719122, 1020.8825985011819, 17700.91149544244, 17790.555236119202, 17833.554161145556, 17983.0, 18199.909000454914, 46557.53442465532, 48056.759716201195, 48280.7585962068, 48456.20354431292, 49072.01855962932, 60957.695211523656, 73594.63202683952, 73945.63027184829, 74628.0, 76931.0, 7968.920310796818, 8292.37807164453, 8329.916700833157, 8385.119562445856, 8684.261837743863, 7127.605735630799, 12294.815577766161, 12576.811347829973, 12801.871981280441, 13080.28058456756, 11004.779904402027, 11227.775444491228, 11434.371109589052, 11480.081593472336, 11611.593594224161, 10464.267501275142, 10718.678439646823, 10898.455077245948, 10991.230613856953, 11101.5559377624, 11322.37726925027, 11406.942965285452, 11441.084713223088, 11687.357195354338, 11776.646700598996, 7989.480683755537, 8037.517748935083, 8185.058718247477, 8296.128906464734, 8531.488110713377, 10204.285700000928, 11410.828837567276, 11627.186096973131, 11682.591109311134, 11726.23779454367], "value": 10757.459985986774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.1595305075168, 1599.5041537123493, 1605.6226786705122, 1850.1211924335942, 1973.546084400588, 7704.229577042293, 7985.401094917883, 8398.0, 8554.230119289263, 8576.614052367642, 8239.83520329593, 8328.791780205498, 8407.495550266989, 8414.91585084149, 8443.282321002722, 2127.7765834587376, 2426.2357357432397, 2452.5217582571318, 2453.766892145243, 2460.5570997220493, 2395.796357309622, 2494.3639371960217, 2494.762997515233, 2495.238952119603, 2496.1263557754824, 2402.267308470916, 2410.0359856057544, 2437.7196622388474, 2452.104981681682, 2452.3746444656676, 2396.221228100874, 2405.494846082325, 2423.3093568333115, 2432.793212576933, 2437.2322718343667, 2437.122635851092, 2444.010175878772, 2445.4742230420543, 2453.3498622864954, 2457.0540341968294, 8511.914880851236, 8519.40364174508, 8558.229759321692, 8577.785555361104, 8587.398882078258, 5089.160288552384, 5351.518363347279, 5352.170413585901, 5371.382291036542, 5372.946270537323, 3233.5796346475045, 3234.110619579611, 3301.233839895668, 3362.428387174162, 3373.3927892979254, 928.4661319741176, 929.1730359979623, 949.5584553182803, 968.6658102954469, 973.2846357926989, 11103.888961110448, 11292.0, 11311.717207069807, 11328.150388720878, 11347.20569560123, 4730.929036064462, 4757.286407038902, 4923.778429970588, 5005.074061298671, 5028.220625803006, 8825.161609647073, 8870.068642792543, 8956.955215223883, 8957.596908139149, 8966.910330896739, 5201.401838788512, 5213.68717876921, 5237.580993520509, 5243.187305967581, 5267.078261304257, 4705.952940470552, 4885.022995400934, 4902.142125128088, 4909.729964851896, 4934.7285899275885, 3383.3909896218424, 3846.249981253629, 3848.7690738555775, 3929.9017524562114, 3995.5205375355144, 1094.9087243365134, 1151.0618845640777, 1208.3897631695938, 1209.7882870497629, 1224.2960297828783, 1058.402002868377, 1090.220492347975, 1090.9127269818555, 1239.646700690299, 1368.6167872995577, 7963.681452741941, 7995.520268783892, 8015.438919275594, 8032.518048917083, 8215.055268644062, 1094.0153861524532, 1114.9442527873573, 1201.237214368882, 1240.1876770715196, 1254.3602762590963, 6232.439080482778, 6378.45783108441, 6390.808275751735, 6396.84007899797, 6406.743730250831, 9667.129958303645, 10549.050585447347, 10574.947125264325, 10617.991290827358, 10669.0, 10402.791944161074, 10518.263721539419, 10526.578936842594, 10562.260641755158, 10579.94710026445, 6329.0, 7933.56365399897, 8165.673373065129, 8225.424220304521, 8432.903722516034, 7769.028871391076, 7904.604769761374, 7943.841123177389, 7950.840983180188, 7963.402744794048, 9373.437593744124, 9727.319087663796, 9731.56207970629, 9766.902330976884, 9828.754281143028, 9822.607095716092, 9828.901710983084, 9898.75253118649, 9899.752506187402, 10128.59485620567, 6775.1531058617675, 6859.07402500676, 6905.136857892763, 6919.308069193242, 6930.0, 7777.883331749915, 7966.880496792669, 7980.401469889665, 7989.720359787612, 7994.880076798969, 7027.15674119109, 7231.385332246818, 7244.384227340735, 7368.926310736824, 7380.040594722652, 7207.0, 7238.23998480173, 7264.091988501437, 7331.4134869209265, 7357.448191385774, 7279.0, 7622.656980436004, 7628.923710762821, 7634.656440460304, 7643.121041080347, 5926.585139040226, 6841.657917104224, 6945.965270173819, 6946.2011868635755, 6964.268751781193, 6892.655932093194, 7030.472714546532, 7030.9296907030275, 7043.577385356895, 7049.08361912948], "value": 4812.537735653639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.86632747918395, 312.65451675898134, 319.4824384497114, 324.53915440075093, 327.2505961348512, 4873.951260487394, 5118.334616499855, 5652.7846512999695, 5940.584159108864, 5945.524358051356, 4973.278874563186, 5581.190727344543, 5770.596058275912, 5833.941660583393, 5886.0, 3830.4062870255157, 4099.323611604097, 4259.382389553512, 4271.914561708764, 4345.174416860794, 3625.5105560749357, 3750.9497340744633, 4209.663226941852, 4352.65067828974, 4376.6498680105515, 4300.871068820938, 4311.124660772574, 4347.891302717426, 4354.475933423309, 4365.192439398721, 4109.630133288018, 4179.498460184767, 4329.480462344523, 4342.826286948518, 4373.671974601886, 3704.685101766353, 3725.9441108383394, 3727.3104475671817, 3735.533058367704, 3736.1220113273357, 5563.721813909288, 5608.49523542879, 5629.380768115504, 5653.434656534355, 5653.519450846683, 4037.001684166327, 4225.281702110648, 4528.547145285478, 4819.951800481986, 4919.975400123012, 5962.463378295931, 6072.599344367169, 6078.908816367758, 6127.5404344674325, 6147.2930612979635, 4073.388991651246, 4080.6531444827224, 4087.693422993287, 4102.0, 4107.774072426016, 5311.7344132793205, 5356.892862142774, 6256.21797275336, 6257.968710156466, 6471.320511346335, 3344.5484859544135, 4074.409210664496, 4124.1133156371525, 4124.422580838685, 4127.277726397869, 3746.894666073515, 4195.098053918422, 4221.746695198298, 4230.767307798039, 4250.06498570314, 3852.6883869677968, 4639.628829693616, 4894.951050489521, 4929.852104436873, 4951.678140920829, 5225.693576605849, 6077.817665470043, 6162.137300777895, 6167.84580385494, 6172.660503672251, 1440.2510694439043, 1457.154850186889, 1458.6717988452513, 1458.8541145885326, 1462.4223431744401, 923.9619955254717, 953.6423841059602, 956.8277710012264, 963.9807203855884, 968.8692026576463, 5707.430456624462, 5710.600257981984, 5761.205815179635, 5765.654060756368, 5805.703779203443, 5391.840754237857, 5553.666779993213, 6330.4619107375465, 6346.873062538816, 6366.631174297549, 5506.531944784658, 5609.242752228479, 5692.316921969307, 5711.628744131618, 5743.483086522233, 2594.5589249827576, 3317.419451595961, 3359.277755282626, 3370.25854312051, 3373.6626337366065, 5578.023845827045, 6334.3032266450655, 6600.900986485207, 6667.2664207674625, 6670.266270710218, 5244.423113457517, 5749.837589325854, 6188.752449902044, 6249.000159974382, 6407.935920640734, 5214.38354110227, 5545.805896793593, 6010.410318403839, 6412.807615771534, 6725.495587830932, 5816.883662326645, 5984.910226346696, 6247.437730604086, 6427.903581446376, 6457.160569125984, 5091.159958606789, 5294.97352513235, 5533.142362933751, 5932.211860425593, 6332.30344662096, 5562.7774889005605, 6168.845778855564, 6645.667716614246, 6669.266380698023, 6673.432758215606, 3549.88781674903, 3839.577646458943, 3912.823922923418, 4146.460960075171, 4192.161567686536, 6218.968905155445, 6292.748290068529, 6353.237611486466, 6361.809145725636, 6362.141110950148, 5467.6719396836315, 5919.549710320999, 6115.938840611715, 6165.383461653978, 6173.38266173397, 5939.673317967553, 6118.663473508822, 6149.323574406902, 6150.969245153746, 6190.907136393048, 5008.724520151281, 5966.582339236385, 5974.581779275582, 6023.397660233942, 6026.397360263939, 4791.880202994953, 5582.106862901916, 6054.455099041107, 6081.939180608138, 6133.417325354084, 5010.473900240422, 5329.790793725267, 5733.369329373682, 6030.0, 6083.543734220039], "value": 4398.482906214908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.4618881800151, 744.4464296349234, 745.5638451505871, 747.0661672908864, 758.7496126278329, 14967.0, 15186.848131518682, 15442.0, 15453.0, 15762.605934851634, 14627.634309142277, 14737.48418805342, 14751.336189871454, 14758.33587488563, 14765.18791466469, 723.9420846332281, 913.1370854542444, 926.4348747264163, 933.8505839065751, 935.1863878425779, 731.6268702961474, 901.6663834381288, 931.7204838548442, 932.8041111366588, 936.2603543200863, 972.3922548407245, 976.1653786012963, 980.2794945714894, 981.2983716642599, 983.6803039012314, 753.2730914667318, 939.628846605587, 975.1613612293422, 978.0073225675944, 986.171615842692, 720.9351158395717, 721.2318880392418, 723.7249845058897, 724.2576359231776, 724.2793420546537, 15468.5359439217, 15594.532164035098, 15619.687606247811, 15646.530604081896, 15662.686746265012, 12582.559610413684, 12606.243625382414, 12626.368681565886, 12961.351932403437, 13148.211107333495, 8587.785305367353, 10173.79652406955, 10185.796284074277, 10217.591296348211, 10277.383356998604, 3481.9303613927577, 3527.770694904823, 3536.2220311531423, 3560.893173204782, 3757.5866654667966, 88831.55584222102, 90996.0, 91236.0, 93129.0, 93479.0, 9486.905130948602, 9701.417914924987, 9704.175145112744, 9711.805763884682, 9954.352967057119, 22838.388861263054, 23008.884955575115, 23011.194608188634, 23116.0, 23321.76678233196, 7475.9252407476315, 7563.281488258606, 7590.240975902366, 7673.0, 7673.040869891263, 4039.818208180639, 4101.774402407897, 4115.36211887158, 4124.649404800565, 4389.4732632083715, 3456.2396272819938, 3565.3047655707405, 3567.6075631680496, 3575.1777091269155, 3580.3018411409525, 605.1830029460193, 617.5399327500951, 618.8793185328817, 625.7340630232134, 633.6229943183798, 545.585355130104, 546.5376837732927, 592.3070008090544, 604.0154548086591, 608.3946473259047, 7977.880331795028, 8035.919640803634, 8069.556174410463, 8137.75586732399, 8226.300764434971, 489.2758717098714, 534.5242733966772, 562.7186406796602, 607.9604825686316, 611.6452457574596, 3613.385724426854, 3784.110733977513, 3798.582155962842, 3918.8432462701744, 4049.817758200888, 94507.3295602266, 95836.0, 96168.55747163798, 97154.0, 98036.50981745188, 80730.0, 81575.5921220402, 81703.0, 81763.82361763775, 83597.58201209077, 60418.697906510184, 66027.33972660308, 70435.0, 70828.29171708217, 73380.63309683418, 7415.4809163360205, 7569.924300756922, 7579.204183560647, 7846.372290216883, 7907.130215676386, 34857.0, 43594.78202608967, 44780.0, 44983.77508112438, 46114.38599648996, 62326.441838952574, 64207.67896160489, 64678.676606618545, 64744.70510589856, 65307.346926532024, 10401.583936642752, 10416.739581510523, 10462.21533384984, 10581.52383142745, 10782.353058816496, 11063.22557421005, 11230.438478075901, 12055.758884822078, 12087.51649934028, 12189.390530473618, 10977.0, 11065.391403472886, 11072.778544429228, 11389.601363952223, 11541.019013383957, 10799.892001079888, 11033.558657653604, 11149.331040137618, 11182.049525790399, 12145.757084858076, 10811.891881081088, 11001.284916480403, 11101.38942358178, 11177.776444471228, 11272.098232141572, 9565.90434095678, 9581.233501320017, 9824.901750982684, 9972.351797133164, 9989.950050249703, 9333.766655833659, 9338.95330523343, 9390.624375024923, 9433.151016408556, 9434.95282523583], "value": 6898.93637777297, "unit": "score"}], "name": "dromaeo_css", "value": 7444.096401782009, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 113.0, 114.0, 114.0, 120.0, 114.0, 114.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 120.0, 144.0, 161.0, 123.0, 141.0, 145.0, 121.0, 162.0, 121.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 187.0, 185.0, 182.0, 184.0, 184.0, 182.0, 185.0, 179.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 86.0, 79.0, 56.0, 58.0, 57.0, 77.0, 80.0, 56.0], "value": 70.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 93.0, 129.0, 78.0, 79.0, 76.0, 119.0, 80.0, 76.0, 119.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 88.0, 85.0, 90.0, 86.0, 88.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 106.0, 148.0, 107.0, 93.0, 95.0, 94.0, 94.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 88.0, 85.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 54.0, 53.0, 55.0, 65.0, 53.0, 53.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 64.0, 74.0, 71.0, 67.0, 68.0, 69.0, 68.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 102.0, 71.0, 85.0, 100.0, 111.0, 111.0, 109.0, 87.0, 86.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 144.0, 138.0, 141.0, 142.0, 142.0, 141.0, 141.0, 145.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 170.0, 170.0, 171.0, 174.0, 169.0, 171.0, 169.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 70.0, 68.0, 68.0, 68.0, 69.0, 70.0, 70.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1479.8, "alertThreshold": 2.0}]} 05:59:18 INFO - Return code: 0 05:59:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:59:18 ERROR - # TBPL SUCCESS # 05:59:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:18 INFO - 2016-04-09 05:59:18.744 screenresolution[1687:10360] starting screenresolution argv=screenresolution get 05:59:18 INFO - 2016-04-09 05:59:18.748 screenresolution[1687:10360] Display 0: 1600x1200x32@60 05:59:18 INFO - 2016-04-09 05:59:18.754 screenresolution[1688:10363] starting screenresolution argv=screenresolution list 05:59:18 INFO - Available Modes on Display 0 05:59:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:18 INFO - Intel Iris: 05:59:18 INFO - Chipset Model: Intel Iris 05:59:18 INFO - Type: GPU 05:59:18 INFO - Bus: Built-In 05:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:18 INFO - Vendor: Intel (0x8086) 05:59:18 INFO - Device ID: 0x0a2e 05:59:18 INFO - Revision ID: 0x0009 05:59:18 INFO - Displays: 05:59:18 INFO - Display: 05:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:18 INFO - Display Serial Number: 1600x1200 60 05:59:18 INFO - Main Display: Yes 05:59:18 INFO - Mirror: Off 05:59:18 INFO - Online: Yes 05:59:18 INFO - Rotation: Supported 05:59:18 INFO - Return code: 0 05:59:18 INFO - Running post-action listener: _resource_record_post_action 05:59:18 INFO - Running post-run listener: _resource_record_post_run 05:59:20 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 32103936; Write bytes: 694408192; Read time: 325; Write time: 2033 05:59:20 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 385686016; Write bytes: 380458496; Read time: 28496; Write time: 669 05:59:20 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30305792; Write bytes: 298573312; Read time: 300; Write time: 1332 05:59:20 INFO - Running post-run listener: _upload_blobber_files 05:59:20 INFO - Blob upload gear active. 05:59:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:20 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 05:59:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:59:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:59:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:21 INFO - (blobuploader) - INFO - Done attempting. 05:59:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:59:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:22 INFO - (blobuploader) - INFO - Done attempting. 05:59:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:22 INFO - Return code: 0 05:59:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85401297236718622e7dea67169b9d57c010f05d1c0882762cc5ab02d93e620b3490fb3f915e6c057972e20cc87d2a31e7c23636b91fe2c9af14493e2ab7199c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/235a43ab9b61fc7a2f946a6ead4c36147e246cd575cc9b7aca7dcb64787deb73cb18c37525f3d853ab4977486089e284b4864093989d392f2cfaa4124bbabe0b"} 05:59:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:22 INFO - Contents: 05:59:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85401297236718622e7dea67169b9d57c010f05d1c0882762cc5ab02d93e620b3490fb3f915e6c057972e20cc87d2a31e7c23636b91fe2c9af14493e2ab7199c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/235a43ab9b61fc7a2f946a6ead4c36147e246cd575cc9b7aca7dcb64787deb73cb18c37525f3d853ab4977486089e284b4864093989d392f2cfaa4124bbabe0b"} 05:59:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:22 INFO - Copying logs to upload dir... 05:59:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.450134 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-09 05:59:22.192359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 05:59:22.196131) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/Firefox/sha512/85401297236718622e7dea67169b9d57c010f05d1c0882762cc5ab02d93e620b3490fb3f915e6c057972e20cc87d2a31e7c23636b91fe2c9af14493e2ab7199c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/235a43ab9b61fc7a2f946a6ead4c36147e246cd575cc9b7aca7dcb64787deb73cb18c37525f3d853ab4977486089e284b4864093989d392f2cfaa4124bbabe0b"} build_url:https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/BRnxSfIuTzyqGlHpX4mVVg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85401297236718622e7dea67169b9d57c010f05d1c0882762cc5ab02d93e620b3490fb3f915e6c057972e20cc87d2a31e7c23636b91fe2c9af14493e2ab7199c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/235a43ab9b61fc7a2f946a6ead4c36147e246cd575cc9b7aca7dcb64787deb73cb18c37525f3d853ab4977486089e284b4864093989d392f2cfaa4124bbabe0b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 05:59:22.233769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-09 05:59:22.234105) ========= 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.1IPlyhN0fB/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.NcmpQnEuch/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005216 ========= master_lag: 6.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-09 05:59:28.607565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 05:59:28.607905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 05:59:28.619555) ========= ========= Total master_lag: 6.67 =========