builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0030 starttime: 1448436513.75 results: success (0) buildid: 20151124224435 builduid: 443c7cee5fdd435fac20dba344b5c840 revision: 30cb3701070945e6701d504883fe2c674eb5196e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:33.751892) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:33.752318) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:33.752636) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005615 basedir: '/builds/slave/test' ========= master_lag: 0.33 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.085179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.085527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.105766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.106116) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.024691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.157040) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.157356) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.157733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.158043) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False --2015-11-24 23:28:34-- 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% 35.2M=0s 2015-11-24 23:28:34 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.342622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.342960) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.146701 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:34.499513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 23:28:34.499905) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 30cb3701070945e6701d504883fe2c674eb5196e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 30cb3701070945e6701d504883fe2c674eb5196e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False 2015-11-24 23:28:34,590 truncating revision to first 12 chars 2015-11-24 23:28:34,590 Setting DEBUG logging. 2015-11-24 23:28:34,591 attempt 1/10 2015-11-24 23:28:34,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/30cb37010709?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 23:28:35,594 unpacking tar archive at: mozilla-aurora-30cb37010709/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 23:28:35.781216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:35.781966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:35.791133) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:35.791430) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 23:28:35.791870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-24 23:28:35.792189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False 23:28:36 INFO - MultiFileLogger online at 20151124 23:28:36 in /builds/slave/test 23:28:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:28:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:28:36 INFO - {'append_to_log': False, 23:28:36 INFO - 'base_work_dir': '/builds/slave/test', 23:28:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:28:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:28:36 INFO - 'branch': 'Mozilla-Aurora', 23:28:36 INFO - 'buildbot_json_path': 'buildprops.json', 23:28:36 INFO - 'config_files': ('talos/mac_config.py',), 23:28:36 INFO - 'default_actions': ('clobber', 23:28:36 INFO - 'read-buildbot-config', 23:28:36 INFO - 'download-and-extract', 23:28:36 INFO - 'populate-webroot', 23:28:36 INFO - 'create-virtualenv', 23:28:36 INFO - 'install', 23:28:36 INFO - 'run-tests'), 23:28:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:28:36 INFO - 'download_minidump_stackwalk': True, 23:28:36 INFO - 'download_symbols': 'ondemand', 23:28:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:28:36 INFO - 'tooltool.py': '/tools/tooltool.py', 23:28:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:28:36 INFO - '/tools/misc-python/virtualenv.py')}, 23:28:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:28:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:28:36 INFO - 'installer_path': 'installer.exe', 23:28:36 INFO - 'log_level': 'info', 23:28:36 INFO - 'log_name': 'talos', 23:28:36 INFO - 'log_to_console': True, 23:28:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:28:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:28:36 INFO - 'opt_config_files': (), 23:28:36 INFO - 'pip_index': False, 23:28:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:28:36 INFO - 'cmd': ('bash', 23:28:36 INFO - '-c', 23:28:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:28:36 INFO - 'enabled': True, 23:28:36 INFO - 'halt_on_failure': False, 23:28:36 INFO - 'name': 'check_screen_resolution'},), 23:28:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:28:36 INFO - 'cmd': ('bash', 23:28:36 INFO - '-c', 23:28:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:28:36 INFO - 'enabled': True, 23:28:36 INFO - 'halt_on_failure': False, 23:28:36 INFO - 'name': 'check_screen_resolution'},), 23:28:36 INFO - 'run_cmd_checks_enabled': True, 23:28:36 INFO - 'sps_profile': False, 23:28:36 INFO - 'sps_profile_interval': 0, 23:28:36 INFO - 'suite': 'dromaeojs', 23:28:36 INFO - 'system_bits': '64', 23:28:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:28:36 INFO - 'title': 't-yosemite-r5-0030', 23:28:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:28:36 INFO - 'use_talos_json': True, 23:28:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:28:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:28:36 INFO - 'work_dir': 'build'} 23:28:36 INFO - ##### 23:28:36 INFO - ##### Running clobber step. 23:28:36 INFO - ##### 23:28:36 INFO - Running pre-action listener: _resource_record_pre_action 23:28:36 INFO - Running main action method: clobber 23:28:36 INFO - rmtree: /builds/slave/test/build 23:28:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:28:40 INFO - Running post-action listener: _resource_record_post_action 23:28:40 INFO - ##### 23:28:40 INFO - ##### Running read-buildbot-config step. 23:28:40 INFO - ##### 23:28:40 INFO - Running pre-action listener: _resource_record_pre_action 23:28:40 INFO - Running main action method: read_buildbot_config 23:28:40 INFO - Using buildbot properties: 23:28:40 INFO - { 23:28:40 INFO - "properties": { 23:28:40 INFO - "buildnumber": 437, 23:28:40 INFO - "product": "firefox", 23:28:40 INFO - "script_repo_revision": "production", 23:28:40 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 23:28:40 INFO - "repository": "", 23:28:40 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 23:28:40 INFO - "buildid": "20151124224435", 23:28:40 INFO - "slavename": "t-yosemite-r5-0030", 23:28:40 INFO - "pgo_build": "False", 23:28:40 INFO - "basedir": "/builds/slave/test", 23:28:40 INFO - "project": "", 23:28:40 INFO - "platform": "yosemite", 23:28:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:28:40 INFO - "slavebuilddir": "test", 23:28:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 23:28:40 INFO - "branch": "mozilla-aurora", 23:28:40 INFO - "repo_path": "releases/mozilla-aurora", 23:28:40 INFO - "stage_platform": "macosx64", 23:28:40 INFO - "builduid": "443c7cee5fdd435fac20dba344b5c840", 23:28:40 INFO - "revision": "30cb3701070945e6701d504883fe2c674eb5196e" 23:28:40 INFO - }, 23:28:40 INFO - "sourcestamp": { 23:28:40 INFO - "repository": "", 23:28:40 INFO - "hasPatch": false, 23:28:40 INFO - "project": "", 23:28:40 INFO - "branch": "mozilla-aurora-macosx64-talos", 23:28:40 INFO - "changes": [ 23:28:40 INFO - { 23:28:40 INFO - "category": null, 23:28:40 INFO - "files": [ 23:28:40 INFO - { 23:28:40 INFO - "url": null, 23:28:40 INFO - "name": "https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 23:28:40 INFO - } 23:28:40 INFO - ], 23:28:40 INFO - "repository": "", 23:28:40 INFO - "rev": "30cb3701070945e6701d504883fe2c674eb5196e", 23:28:40 INFO - "who": "jdaggett@mozilla.com", 23:28:40 INFO - "when": 1448436496, 23:28:40 INFO - "number": 6704165, 23:28:40 INFO - "comments": "Bug 1163487 - sniff LANGUAGE when determining language for lang group. r=karlt, a=ritu", 23:28:40 INFO - "project": "", 23:28:40 INFO - "at": "Tue 24 Nov 2015 23:28:16", 23:28:40 INFO - "branch": "mozilla-aurora-macosx64-talos", 23:28:40 INFO - "revlink": "", 23:28:40 INFO - "properties": [ 23:28:40 INFO - [ 23:28:40 INFO - "buildid", 23:28:40 INFO - "20151124224435", 23:28:40 INFO - "Change" 23:28:40 INFO - ], 23:28:40 INFO - [ 23:28:40 INFO - "builduid", 23:28:40 INFO - "443c7cee5fdd435fac20dba344b5c840", 23:28:40 INFO - "Change" 23:28:40 INFO - ], 23:28:40 INFO - [ 23:28:40 INFO - "pgo_build", 23:28:40 INFO - "False", 23:28:40 INFO - "Change" 23:28:40 INFO - ] 23:28:40 INFO - ], 23:28:40 INFO - "revision": "30cb3701070945e6701d504883fe2c674eb5196e" 23:28:40 INFO - } 23:28:40 INFO - ], 23:28:40 INFO - "revision": "30cb3701070945e6701d504883fe2c674eb5196e" 23:28:40 INFO - } 23:28:40 INFO - } 23:28:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 23:28:40 INFO - Running post-action listener: _resource_record_post_action 23:28:40 INFO - ##### 23:28:40 INFO - ##### Running download-and-extract step. 23:28:40 INFO - ##### 23:28:40 INFO - Running pre-action listener: _resource_record_pre_action 23:28:40 INFO - Running main action method: download_and_extract 23:28:40 INFO - mkdir: /builds/slave/test/build/tests 23:28:40 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')]} 23:28:40 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/test_packages.json 23:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/test_packages.json 23:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:28:41 INFO - Downloaded 1149 bytes. 23:28:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:28:41 INFO - Using the following test package requirements: 23:28:41 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 23:28:41 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 23:28:41 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'jsshell-mac.zip'], 23:28:41 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 23:28:41 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 23:28:41 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 23:28:41 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 23:28:41 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 23:28:41 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 23:28:41 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 23:28:41 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 23:28:41 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 23:28: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')]} 23:28:41 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:28:43 INFO - Downloaded 17447976 bytes. 23:28:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 23:28:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 23:28:47 INFO - Return code: 0 23:28:47 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 23:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:47 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 23:28:54 INFO - Downloaded 17447976 bytes. 23:28:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 23:28:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 23:28:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 23:29:00 INFO - Return code: 0 23:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:00 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:29:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 23:29:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 23:29:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 23:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 23:29:01 INFO - Downloaded 11131307 bytes. 23:29:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 23:29:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 23:29:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:29:02 INFO - Return code: 0 23:29:02 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')]} 23:29:02 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 23:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 23:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 23:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 23:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 23:29:05 INFO - Downloaded 107807637 bytes. 23:29:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 23:29:05 INFO - mkdir: /builds/slave/test/properties 23:29:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:29:05 INFO - Writing to file /builds/slave/test/properties/build_url 23:29:05 INFO - Contents: 23:29:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 23:29:05 INFO - Running post-action listener: _resource_record_post_action 23:29:05 INFO - Running post-action listener: set_extra_try_arguments 23:29:05 INFO - ##### 23:29:05 INFO - ##### Running populate-webroot step. 23:29:05 INFO - ##### 23:29:05 INFO - Running pre-action listener: _resource_record_pre_action 23:29:05 INFO - Running main action method: populate_webroot 23:29:05 INFO - Guessing talos json url... 23:29:05 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')]} 23:29:05 INFO - https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 23:29:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 23:29:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 23:29:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 23:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 23:29:05 INFO - Downloaded 107 bytes. 23:29:05 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 23:29:05 INFO - Contents: 23:29:05 INFO - 20151124224435 23:29:05 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/30cb3701070945e6701d504883fe2c674eb5196e 23:29:05 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')]} 23:29:05 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/30cb370107/testing/talos/talos.json 23:29:05 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/30cb370107/testing/talos/talos.json to /builds/slave/test/build/talos.json 23:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/30cb370107/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 23:29:06 INFO - Downloaded 4264 bytes. 23:29:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:29:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:29:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:29:06 INFO - '../fennec_ids.txt'], 23:29:06 INFO - 'tests': ['tcheck2']}, 23:29:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:29:06 INFO - '--tppagecycles', 23:29:06 INFO - '7'], 23:29:06 INFO - 'tests': ['tsvgm']}}, 23:29:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:29:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:29:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:29:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:29:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'tests': ['damp', 'tps']}, 23:29:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['damp', 'tps']}, 23:29:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:29:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:29:06 INFO - 'other': {'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'other_l64': {'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'other_nol64': {'tests': ['a11yr', 23:29:06 INFO - 'ts_paint', 23:29:06 INFO - 'tpaint', 23:29:06 INFO - 'sessionrestore', 23:29:06 INFO - 'sessionrestore_no_auto_restore']}, 23:29:06 INFO - 'svgr': {'tests': ['tsvgx', 23:29:06 INFO - 'tsvgr_opacity', 23:29:06 INFO - 'tart', 23:29:06 INFO - 'tscrollx', 23:29:06 INFO - 'cart']}, 23:29:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['tsvgx', 23:29:06 INFO - 'tsvgr_opacity', 23:29:06 INFO - 'tart', 23:29:06 INFO - 'tscrollx', 23:29:06 INFO - 'cart']}, 23:29:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'tests': ['tp5o']}, 23:29:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'talos_options': ['--e10s'], 23:29:06 INFO - 'tests': ['tp5o']}, 23:29:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'talos_options': ['--xperf_path', 23:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:06 INFO - 'tests': ['tp5n']}, 23:29:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:06 INFO - 'talos_options': ['--e10s', 23:29:06 INFO - '--xperf_path', 23:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 23:29:06 INFO - 'C:/slave/talos-data/talos/xperf.config'], 23:29:06 INFO - 'tests': ['tp5n']}}, 23:29:06 INFO - 'talos.zip': {'path': '', 23:29:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:29:06 INFO - Running post-action listener: _resource_record_post_action 23:29:06 INFO - ##### 23:29:06 INFO - ##### Running create-virtualenv step. 23:29:06 INFO - ##### 23:29:06 INFO - Running pre-action listener: _resource_record_pre_action 23:29:06 INFO - Running main action method: create_virtualenv 23:29:06 INFO - Creating virtualenv /builds/slave/test/build/venv 23:29:06 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 23:29:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:29:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:29:06 INFO - Using real prefix '/tools/python27' 23:29:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:29:07 INFO - Installing distribute.............................................................................................................................................................................................done. 23:29:11 INFO - Installing pip.................done. 23:29:11 INFO - Return code: 0 23:29:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:11 INFO - 'HOME': '/Users/cltbld', 23:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:11 INFO - 'LOGNAME': 'cltbld', 23:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:11 INFO - 'MOZ_NO_REMOTE': '1', 23:29:11 INFO - 'NO_EM_RESTART': '1', 23:29:11 INFO - 'PAGER': '/bin/cat', 23:29:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:11 INFO - 'PWD': '/builds/slave/test', 23:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:11 INFO - 'SHELL': '/bin/bash', 23:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:11 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:11 INFO - 'USER': 'cltbld', 23:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:11 INFO - 'XPC_FLAGS': '0x0', 23:29:11 INFO - 'XPC_SERVICE_NAME': '0', 23:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:12 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 23:29:12 INFO - Cleaning up... 23:29:12 INFO - Return code: 0 23:29:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:29:12 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')]} 23:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:12 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')]} 23:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:12 INFO - 'HOME': '/Users/cltbld', 23:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:12 INFO - 'LOGNAME': 'cltbld', 23:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:12 INFO - 'MOZ_NO_REMOTE': '1', 23:29:12 INFO - 'NO_EM_RESTART': '1', 23:29:12 INFO - 'PAGER': '/bin/cat', 23:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:12 INFO - 'PWD': '/builds/slave/test', 23:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:12 INFO - 'SHELL': '/bin/bash', 23:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:12 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:12 INFO - 'USER': 'cltbld', 23:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:12 INFO - 'XPC_FLAGS': '0x0', 23:29:12 INFO - 'XPC_SERVICE_NAME': '0', 23:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:12 INFO - Downloading/unpacking psutil>=0.7.1 23:29:12 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 23:29:12 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 23:29:12 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 23:29:12 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 23:29:12 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 23:29:12 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 23:29:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:15 INFO - Installing collected packages: psutil 23:29:15 INFO - Running setup.py install for psutil 23:29:15 INFO - building 'psutil._psutil_osx' extension 23:29:15 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 23:29:17 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 23:29:17 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 23:29:17 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 23:29:17 INFO - building 'psutil._psutil_posix' extension 23:29:17 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 23:29:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:29:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:29:17 INFO - ^ 23:29:17 INFO - 1 warning generated. 23:29:17 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 23:29:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:17 INFO - Successfully installed psutil 23:29:17 INFO - Cleaning up... 23:29:18 INFO - Return code: 0 23:29:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:18 INFO - 'HOME': '/Users/cltbld', 23:29:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:18 INFO - 'LOGNAME': 'cltbld', 23:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:18 INFO - 'MOZ_NO_REMOTE': '1', 23:29:18 INFO - 'NO_EM_RESTART': '1', 23:29:18 INFO - 'PAGER': '/bin/cat', 23:29:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:18 INFO - 'PWD': '/builds/slave/test', 23:29:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:18 INFO - 'SHELL': '/bin/bash', 23:29:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:18 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:18 INFO - 'USER': 'cltbld', 23:29:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:18 INFO - 'XPC_FLAGS': '0x0', 23:29:18 INFO - 'XPC_SERVICE_NAME': '0', 23:29:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:29:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:29:20 INFO - Installing collected packages: mozsystemmonitor 23:29:20 INFO - Running setup.py install for mozsystemmonitor 23:29:20 INFO - Successfully installed mozsystemmonitor 23:29:20 INFO - Cleaning up... 23:29:21 INFO - Return code: 0 23:29:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:21 INFO - 'HOME': '/Users/cltbld', 23:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:21 INFO - 'LOGNAME': 'cltbld', 23:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:21 INFO - 'MOZ_NO_REMOTE': '1', 23:29:21 INFO - 'NO_EM_RESTART': '1', 23:29:21 INFO - 'PAGER': '/bin/cat', 23:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:21 INFO - 'PWD': '/builds/slave/test', 23:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:21 INFO - 'SHELL': '/bin/bash', 23:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:21 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:21 INFO - 'USER': 'cltbld', 23:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:21 INFO - 'XPC_FLAGS': '0x0', 23:29:21 INFO - 'XPC_SERVICE_NAME': '0', 23:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:21 INFO - Downloading/unpacking blobuploader==1.2.4 23:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:23 INFO - Downloading blobuploader-1.2.4.tar.gz 23:29:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:29:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:29:23 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 23:29:23 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 23:29:23 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 23:29:23 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 23:29:23 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 23:29:23 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 23:29:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:29:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:24 INFO - Downloading docopt-0.6.1.tar.gz 23:29:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:29:25 INFO - Installing collected packages: blobuploader, requests, docopt 23:29:25 INFO - Running setup.py install for blobuploader 23:29:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:29:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:29:25 INFO - Running setup.py install for requests 23:29:25 INFO - Running setup.py install for docopt 23:29:25 INFO - Successfully installed blobuploader requests docopt 23:29:25 INFO - Cleaning up... 23:29:26 INFO - Return code: 0 23:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 23:29:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:26 INFO - 'HOME': '/Users/cltbld', 23:29:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:26 INFO - 'LOGNAME': 'cltbld', 23:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:26 INFO - 'MOZ_NO_REMOTE': '1', 23:29:26 INFO - 'NO_EM_RESTART': '1', 23:29:26 INFO - 'PAGER': '/bin/cat', 23:29:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:26 INFO - 'PWD': '/builds/slave/test', 23:29:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:26 INFO - 'SHELL': '/bin/bash', 23:29:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:26 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:26 INFO - 'USER': 'cltbld', 23:29:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:26 INFO - 'XPC_FLAGS': '0x0', 23:29:26 INFO - 'XPC_SERVICE_NAME': '0', 23:29:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-VbQ3Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-L5ckij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-gzeyIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-ugTfL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-F5iQcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:26 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-TNYPFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-3ZUX01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-COilMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-GJotfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-zxyUca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-DkblHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-LHZz36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-I111nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:27 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-XT8pKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:28 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-PxFUQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:28 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-t3tRXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:28 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-cfBXin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:29:28 INFO - Running setup.py install for manifestparser 23:29:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:29:28 INFO - Running setup.py install for mozcrash 23:29:28 INFO - Running setup.py install for mozdebug 23:29:28 INFO - Running setup.py install for mozdevice 23:29:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Running setup.py install for mozfile 23:29:29 INFO - Running setup.py install for mozhttpd 23:29:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Running setup.py install for mozinfo 23:29:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Running setup.py install for mozInstall 23:29:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:29:29 INFO - Running setup.py install for mozleak 23:29:29 INFO - Running setup.py install for mozlog 23:29:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Running setup.py install for moznetwork 23:29:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Running setup.py install for mozprocess 23:29:30 INFO - Running setup.py install for mozprofile 23:29:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Running setup.py install for mozrunner 23:29:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:29:30 INFO - Running setup.py install for mozscreenshot 23:29:30 INFO - Running setup.py install for moztest 23:29:31 INFO - Running setup.py install for mozversion 23:29:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:29:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:31 INFO - Cleaning up... 23:29:31 INFO - Return code: 0 23:29:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:31 INFO - 'HOME': '/Users/cltbld', 23:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:31 INFO - 'LOGNAME': 'cltbld', 23:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:31 INFO - 'MOZ_NO_REMOTE': '1', 23:29:31 INFO - 'NO_EM_RESTART': '1', 23:29:31 INFO - 'PAGER': '/bin/cat', 23:29:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:31 INFO - 'PWD': '/builds/slave/test', 23:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:31 INFO - 'SHELL': '/bin/bash', 23:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:31 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:31 INFO - 'USER': 'cltbld', 23:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:31 INFO - 'XPC_FLAGS': '0x0', 23:29:31 INFO - 'XPC_SERVICE_NAME': '0', 23:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:29:31 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-7GEY23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:29:31 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)) 23:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:29:31 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-P_O8cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 23:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:29:31 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-W1yE0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:29:32 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-NoJA8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-bwQvH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:29:32 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-oKSIEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:29:32 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-KR7hDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-2xgfrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:29:32 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-SvSp3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:29:32 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-4zv9b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 23:29:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:29:32 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-7LoUcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:29:33 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-c5qeor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:29:33 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-L43aEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-CcZzRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:29:33 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-W_QIYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:29:33 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-T22LIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:29:33 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)) 23:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:29:33 INFO - Running setup.py (path:/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/pip-q5zVVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:29:33 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)) 23:29:33 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:29:33 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:29:33 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)) 23:29:33 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:29:33 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:29:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:29:33 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 23:29:33 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 23:29:33 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 23:29:33 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 23:29:33 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 23:29:33 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 23:29:36 INFO - Downloading blessings-1.5.1.tar.gz 23:29:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 23:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:29:36 INFO - Installing collected packages: blessings 23:29:36 INFO - Running setup.py install for blessings 23:29:36 INFO - Successfully installed blessings 23:29:36 INFO - Cleaning up... 23:29:36 INFO - Return code: 0 23:29:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:29:36 INFO - Reading from file tmpfile_stdout 23:29:36 INFO - Current package versions: 23:29:36 INFO - blessings == 1.5.1 23:29:36 INFO - blobuploader == 1.2.4 23:29:36 INFO - docopt == 0.6.1 23:29:36 INFO - manifestparser == 1.1 23:29:36 INFO - mozInstall == 1.12 23:29:36 INFO - mozcrash == 0.16 23:29:36 INFO - mozdebug == 0.1 23:29:36 INFO - mozdevice == 0.46 23:29:36 INFO - mozfile == 1.2 23:29:36 INFO - mozhttpd == 0.7 23:29:36 INFO - mozinfo == 0.8 23:29:36 INFO - mozleak == 0.1 23:29:36 INFO - mozlog == 3.0 23:29:36 INFO - moznetwork == 0.27 23:29:36 INFO - mozprocess == 0.22 23:29:36 INFO - mozprofile == 0.27 23:29:36 INFO - mozrunner == 6.11 23:29:36 INFO - mozscreenshot == 0.1 23:29:36 INFO - mozsystemmonitor == 0.0 23:29:36 INFO - moztest == 0.7 23:29:36 INFO - mozversion == 1.4 23:29:36 INFO - psutil == 3.1.1 23:29:36 INFO - requests == 1.2.3 23:29:36 INFO - wsgiref == 0.1.2 23:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10cf94a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d001228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf517026b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/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.QgZ5SghWNP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 23:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 23:29:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:29:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:29:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:29:36 INFO - 'HOME': '/Users/cltbld', 23:29:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:29:36 INFO - 'LOGNAME': 'cltbld', 23:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:36 INFO - 'MOZ_NO_REMOTE': '1', 23:29:36 INFO - 'NO_EM_RESTART': '1', 23:29:36 INFO - 'PAGER': '/bin/cat', 23:29:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:36 INFO - 'PWD': '/builds/slave/test', 23:29:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:29:36 INFO - 'SHELL': '/bin/bash', 23:29:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:29:36 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:29:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:29:36 INFO - 'USER': 'cltbld', 23:29:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:29:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:36 INFO - 'XPC_FLAGS': '0x0', 23:29:36 INFO - 'XPC_SERVICE_NAME': '0', 23:29:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:37 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 1)) 23:29:37 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 2)) 23:29:37 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 3)) 23:29:37 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 4)) 23:29:37 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 5)) 23:29:37 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 6)) 23:29:37 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 7)) 23:29:37 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 8)) 23:29:37 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:29:37 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 3)) 23:29:37 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:29:37 INFO - Cleaning up... 23:29:37 INFO - Return code: 0 23:29:37 INFO - Running post-action listener: _resource_record_post_action 23:29:37 INFO - Running post-action listener: _start_resource_monitoring 23:29:37 INFO - Starting resource monitoring. 23:29:37 INFO - ##### 23:29:37 INFO - ##### Running install step. 23:29:37 INFO - ##### 23:29:37 INFO - Running pre-action listener: _resource_record_pre_action 23:29:37 INFO - Running main action method: install 23:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:29:37 INFO - Reading from file tmpfile_stdout 23:29:37 INFO - Detecting whether we're running mozinstall >=1.0... 23:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:29:37 INFO - Reading from file tmpfile_stdout 23:29:37 INFO - Output received: 23:29:37 INFO - Usage: mozinstall [options] installer 23:29:37 INFO - Options: 23:29:37 INFO - -h, --help show this help message and exit 23:29:37 INFO - -d DEST, --destination=DEST 23:29:37 INFO - Directory to install application into. [default: 23:29:37 INFO - "/builds/slave/test"] 23:29:37 INFO - --app=APP Application being installed. [default: firefox] 23:29:37 INFO - mkdir: /builds/slave/test/build/application 23:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 23:30:15 INFO - Reading from file tmpfile_stdout 23:30:15 INFO - Output received: 23:30:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 23:30:15 INFO - Running post-action listener: _resource_record_post_action 23:30:15 INFO - ##### 23:30:15 INFO - ##### Running run-tests step. 23:30:15 INFO - ##### 23:30:15 INFO - Running pre-action listener: _resource_record_pre_action 23:30:15 INFO - Running main action method: run_tests 23:30:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:30:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:30:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:30:15 INFO - 2015-11-24 23:30:15.848 screenresolution[1629:8018] starting screenresolution argv=screenresolution get 23:30:15 INFO - 2015-11-24 23:30:15.851 screenresolution[1629:8018] Display 0: 1600x1200x32@60 23:30:15 INFO - 2015-11-24 23:30:15.857 screenresolution[1630:8020] starting screenresolution argv=screenresolution list 23:30:15 INFO - Available Modes on Display 0 23:30:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:30:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:30:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:30:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:30:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:30:16 INFO - Intel HD Graphics 3000: 23:30:16 INFO - Chipset Model: Intel HD Graphics 3000 23:30:16 INFO - Type: GPU 23:30:16 INFO - Bus: Built-In 23:30:16 INFO - VRAM (Total): 512 MB 23:30:16 INFO - VRAM (Dynamic, Max): 10 23:30:16 INFO - Vendor: Intel (0x8086) 23:30:16 INFO - Device ID: 0x0116 23:30:16 INFO - Revision ID: 0x0009 23:30:16 INFO - Displays: 23:30:16 INFO - Display: 23:30:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:30:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:30:16 INFO - Display Serial Number: 1600x1200 60 23:30:16 INFO - Main Display: Yes 23:30:16 INFO - Mirror: Off 23:30:16 INFO - Online: Yes 23:30:16 INFO - Rotation: Supported 23:30:16 INFO - Return code: 0 23:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:16 INFO - Python 2.7.3 23:30:16 INFO - Return code: 0 23:30:16 INFO - grabbing minidump binary from tooltool 23:30:16 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')]} 23:30:16 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 0x10cf499f0>, '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 0x10cca8cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf13990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:16 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 23:30:16 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 23:30:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:16 INFO - Return code: 0 23:30:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:30:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:30:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0030', '--webServer', 'localhost'] in /builds/slave/test/build 23:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0030 --webServer localhost 23:30:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AFHUeEoMJT/Render', 23:30:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:30:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:30:16 INFO - 'HOME': '/Users/cltbld', 23:30:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:30:16 INFO - 'LOGNAME': 'cltbld', 23:30:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:16 INFO - 'MOZ_NO_REMOTE': '1', 23:30:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:16 INFO - 'NO_EM_RESTART': '1', 23:30:16 INFO - 'PAGER': '/bin/cat', 23:30:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:16 INFO - 'PWD': '/builds/slave/test', 23:30:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:30:16 INFO - 'SHELL': '/bin/bash', 23:30:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QgZ5SghWNP/Listeners', 23:30:16 INFO - 'TMPDIR': '/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/', 23:30:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:30:16 INFO - 'USER': 'cltbld', 23:30:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:30:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:16 INFO - 'XPC_FLAGS': '0x0', 23:30:16 INFO - 'XPC_SERVICE_NAME': '0', 23:30:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:30:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0030', '--webServer', 'localhost'] with output_timeout 3600 23:30:16 INFO - mozversion INFO | application_buildid: 20151124224435 23:30:16 INFO - mozversion INFO | application_changeset: 30cb3701070945e6701d504883fe2c674eb5196e 23:30:16 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 23:30:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:16 INFO - mozversion INFO | application_name: Firefox 23:30:16 INFO - mozversion INFO | application_remotingname: firefox-dev 23:30:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:30:16 INFO - mozversion INFO | application_vendor: Mozilla 23:30:16 INFO - mozversion INFO | application_version: 44.0a2 23:30:16 INFO - mozversion INFO | platform_buildid: 20151124224435 23:30:16 INFO - mozversion INFO | platform_changeset: 30cb3701070945e6701d504883fe2c674eb5196e 23:30:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:30:16 INFO - mozversion INFO | platform_version: 44.0a2 23:30:16 INFO - 2015-11-24 23:30:16,553 DEBUG : using testdate: 1448436616 23:30:16 INFO - 2015-11-24 23:30:16,553 DEBUG : actual date: 1448436616 23:30:16 INFO - 2015-11-24 23:30:16,601 INFO : starting webserver on 'localhost:49270' 23:30:16 INFO - 2015-11-24 23:30:16,602 INFO : Starting test suite t-yosemite-r5-0030 23:30:16 INFO - 2015-11-24 23:30:16,603 INFO : Starting test dromaeo_css 23:30:16 INFO - 2015-11-24 23:30:16,603 DEBUG : operating with platform_type : mac_ 23:30:16 INFO - 2015-11-24 23:30:16,603 INFO : Initialising browser for dromaeo_css test... 23:30:16 INFO - 2015-11-24 23:30:16,628 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpAL_IvC/profile http://localhost:49270/getInfo.html 23:30:19 INFO - 2015-11-24 23:30:19,766 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:30:19 INFO - 2015-11-24 23:30:19,766 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:30:19 INFO - 2015-11-24 23:30:19,766 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:30:19 INFO - 2015-11-24 23:30:19,766 DEBUG : BROWSER_OUTPUT: __metrics 23:30:19 INFO - 2015-11-24 23:30:19,784 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:20 INFO - 2015-11-24 23:30:20,478 INFO : Browser initialized. 23:30:20 INFO - 2015-11-24 23:30:20,479 INFO : Running cycle 1/1 for dromaeo_css test... 23:30:20 INFO - 2015-11-24 23:30:20,479 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpAL_IvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:30:32 INFO - 2015-11-24 23:30:32,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 199311360 23:30:32 INFO - 2015-11-24 23:30:32,437 DEBUG : BROWSER_OUTPUT: 23:31:24 INFO - 2015-11-24 23:31:24,073 DEBUG : BROWSER_OUTPUT: 1448436684070 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] 23:33:34 INFO - 2015-11-24 23:33:34,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 23:33:35 INFO - 2015-11-24 23:33:35,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 327733248 23:33:35 INFO - 2015-11-24 23:33:35,729 DEBUG : BROWSER_OUTPUT: 23:36:38 INFO - 2015-11-24 23:36:38,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 23:36:39 INFO - 2015-11-24 23:36:39,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 345907200 23:36:39 INFO - 2015-11-24 23:36:39,033 DEBUG : BROWSER_OUTPUT: 23:39:41 INFO - 2015-11-24 23:39:41,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 23:39:41 INFO - 2015-11-24 23:39:41,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 317075456 23:39:41 INFO - 2015-11-24 23:39:41,645 DEBUG : BROWSER_OUTPUT: 23:42:43 INFO - 2015-11-24 23:42:43,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 23:42:44 INFO - 2015-11-24 23:42:44,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 302465024 23:42:44 INFO - 2015-11-24 23:42:44,218 DEBUG : BROWSER_OUTPUT: 23:45:47 INFO - 2015-11-24 23:45:47,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 23:45:47 INFO - 2015-11-24 23:45:47,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 302911488 23:45:47 INFO - 2015-11-24 23:45:47,838 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 23:48:50 INFO - 2015-11-24 23:48:50,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 348712960 23:48:50 INFO - 2015-11-24 23:48:50,631 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,631 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:48:50 INFO - 2015-11-24 23:48:50,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:48:50 INFO - 2015-11-24 23:48:50,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:48:50 INFO - 2015-11-24 23:48:50,632 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:48:50 INFO - 2015-11-24 23:48:50,633 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2988.656304524979;3008.1577158395658;3029.742471889889;3039.0578920534645;3168;5070.569001634865;5090.516400941905;5092.108880945833;5097.464766199542;5133.82031628893;5081.6696914700515;5088.389393272803;5091.363579552556;5208.453112423198;5220.269162317279;4671.743054132022;4736.928946065812;4765.332853400527;4777.3072904428755;4806.663533552653;4801.135795556798;4818.7831547580445;4821.083994041139;4828.806847726087;4863.416390033201;4710.057988402316;4821.421429428474;4831.396075490564;4834.540718631724;4836.613070954333;4706.788194531271;4842.080004799077;4847.684900481493;4872.829450969234;5019.196928491424;4711.505291944331;4737.099951009297;4751.596114330286;4760.166970780099;4809.1343558159515;4928.186849169882;4955.479674634147;5003.474635163292;5077.289179514871;5081;5435.9943410468795;5442.346918369782;5453.481919217668;5461.890762184774;5470.234167216593;5473.808416705396;5536.197251398525;5541.196526503675;5551.472610102074;5562.415946325618;4863.489333619955;4980.850574482772;4991.725455100004;5090.49095090488;5099.796008159669;5461.15352120422;5475.425080366584;5478.986387518322;5489.1217405215775;5511.862203444946;5253.44838791929;5269.0252303324005;5276.07668657991;5280.155175171954;5334.546563542065;5323.494268044529;5338.012467693489;5405.891882162335;5425.159100339453;5445.128779395278;5292.761825717852;5404.83785486436;5412.188171774265;5423.240746295522;5465.289512363367;5451.318585176853;5456.91814622781;5457.045017121988;5486.423925487767;5535.252740880011;3988.3618621020496;4013.4381186633896;4095.28332541804;4107.034846810997;4175.227582897113;3715.777053376806;3715.851365945332;3724.9942515521197;3726.6832319253167;3755.1363186467265;5047.091523525801;5054.292399064134;5062.417821950523;5083.822066227664;5106.463821298785;5169.121249387613;5323.148296272578;5423.511883930465;5443.755031023535;5454.427285135083;5000.274960130833;5125.308083408767;5142.100132476801;5180.0416922868635;5183.403908550565;4645.094206629675;4790.185668436374;4800.807967681254;4812.446568644581;4882.829100981519;5281.60387970896;5329.227262046981;5432.837014889559;5447.291852059207;5523.944760552424;5352.785888564569;5381.650192737459;5405.081136206775;5406.324209473816;5442.537384322377;5369.4630536946;5383.569314454756;5404.459554044564;5462.8907421850545;5469.781208751605;5162.09663308912;5261.237120617566;5293.602979776455;5323.813666521653;5342.679439233659;5313.335833020872;5342.973285133705;5360.276362691143;5372.5433338166695;5419.647722897999;5180.792768289226;5200.947990520046;5251.894962100813;5279.683219006872;5304.045271851104;5101.0818052750865;5162.148245539444;5199.870003249949;5251.054810134213;5345.358556973188;5155.252488389087;5164.302819119371;5200.5059519345605;5203.765830537711;5319.601029922694;5276.314079169837;5291.1798671206025;5305.071612467726;5314.28257185275;5324.733763311741;4869.926951095807;4987.2768448574025;5152.355955505562;5235.1623740201385;5257.4742525747115 23:48:50 INFO - 2015-11-24 23:48:50,635 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.6787259771538;527.5621234375469;533.9946600533993;544.6106034185558;559.5160186438732;29997.250068748293;31407;36881.44677829835;37469.437958430644;37943;41322.7933860331;41547.376789348185;41992.79003604985;42053;42097.368539471936;8075.152109028556;8509.446885952393;8703.260222881063;8793.208611224989;8796.47221166732;8035.075966263867;10301.330413523097;10499.265051446402;10656.520456579434;10697;10241.28311018229;10373.429461379621;10411.791764164713;10534.209934254923;10536.947315263451;8203.794905127419;8327.625256863455;10262.38425694457;10284.228682848816;10312.89687103127;10162.237832162617;10190.286679932407;10236.94881525595;10244.436555989418;10320.896791032068;37684.43473347902;38149;38202.42696359557;38255.61744382548;38596.421053684215;2874.8275103493856;2889.3426373800517;2894.9855250723613;3407.944248099925;3410.2326976430354;25961.870190649115;25965;26725.331866703295;26932.461350772875;27114.322141946413;2136;2147.226998280618;2205.2612374854443;2237.574860776447;2293.7820907013806;269335;270908;271026.999999998;271485;271952;55234.723826380614;56424.71787641035;63502.36497634964;64625.67687161534;65512.344876550625;59221.40778592245;59769;59913.101303480486;60532.394676052674;60542.39457605367;15762.684746305238;16068.276927538289;16088.75866861998;16099.597510062107;16130.677386452206;11970.82043769344;12191.87808121925;12231.510739570496;12369.443375048144;12429.689257768447;19071.637244375805;19385.806141938683;19481.12334944931;19495.90252048759;19578.31475898365;7682.308592226726;7888.447808653454;7892.802679933047;7894.723684671009;7970.681172753141;820.4953953318666;937.854632531945;992.151710287708;1037.4127584795276;1088.1403691084113;27814.86092569524;27824.721752782618;27929.860350698116;28118.718812812018;30151.396972060436;923.1599244687302;1026.779242462874;1045.7856139491387;1104.2380757277454;1136.1138312116561;13970.161790292615;14176.574702758933;14403;14514.346854391577;14523.128612283297;321738;321886;322080;322092;326260;45286.09427811425;46122.76938615285;46285.305720414224;52436.21345679818;52779.47220527822;1313.934303284832;1338.8928885689122;1350.9324533773272;1361.720847226336;1363.270650202157;25476.49047019012;25618.487630247662;26138.215853524423;28018.579721304606;28803.711962880105;44183.33724994063;45451.77274113608;45588.54411455843;51355;52221;197948;199451;204690;206819;207123;29072.709272907847;29396.118116456542;30186.094417167522;30483.542746859257;30496.847515762278;37505.62494375021;39966.40050399304;40036.59963400445;42026.159476810906;42103.57896420996;33308;33799.83100084484;35086.12284692903;35187.47218791669;35479.11302217465;31430.528542071428;31594.36811263716;32033.199170020936;32060.5190922141;32227.033189004367;31980.68019319777;32214.516782247818;32731.672683272864;32852;33043.504347434326;28132.71867281383;30099.247518812204;30222.395552088394;30279.545806813356;30561.388772224876;22897.88551057234;23040.308790736304;23062;23157.88421057884;23219.419514511595 23:48:50 INFO - 2015-11-24 23:48:50,639 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.43412810517555;326.5428400239664;328.06828606756807;328.5285615142271;337.9273456206915;14088.225147616877;14377.424903003894;16036.75944860828;16713.83003189777;17232.82767172328;14071.92964035181;15186.31661575229;18394.816051839476;18412;18891.90554047228;5407.918881216785;5660.858478538049;5679.034564124109;5743.081107022877;5754.971225143869;4126.504819421673;4276.016516201275;5516.889662206753;5610.579206559504;6173;6353.777617783378;6372.107904893319;6414.9679251603675;6414.9679251603675;6437.388448097447;6281.371862813728;6306.274778400497;6338.397852204056;6342.619442833445;6407.103005579223;5916.526677865761;6076.270847498285;6105.664188469633;6123.295820980599;6145.477634401082;22258.109675612955;23309.766902330928;23358.883205584032;23376.53246935069;23986.160484383137;1804.5398423401948;1966.547694030381;1996.2114964588907;1998.590288990768;2148.387709502784;13477.528286509925;13691;13855.237961912091;14311.78532322016;14381.209033503153;1665.225670063414;1739.6346767178907;1757.0775342944928;1758.4460894818092;1763.0920076160787;55195.72402137964;57797.71101144468;58544;61301.999999999556;64435.67782161106;16189.19054047293;16758.24587893548;16768.245428955724;16815.495535133967;17009.829901700825;23473.178438754563;23483.88258058699;24206.878965605058;24289.149879754124;24403.511929761306;9274.118958698913;9486.715398538056;9502.052079323723;9548.092931171528;9556.808863822685;7962.163972782774;8004.319632831274;8055.516668999761;8060.314873235723;8068.919310806934;7891.881621775678;7933.761987140395;7936.920630793734;7937.3650107991225;7971.800704982305;992.8009459048243;999.7750506136061;1004.1163775877181;2054.0243384392293;3118.781685282054;408.2386349458239;417.21771678103556;428.3617410059052;433.87417648882104;438.87053319270893;9582.377145485521;10402.427866467266;10641.467926603638;10987.230893837515;11027;441.7062653335496;448.9797959091849;453.8411555955455;459.8413547326167;463.48321621391904;5864.0031194697;6035.8792824143275;6045.486133678686;6062.696865156725;6183.979643358885;513487;522956;527788;529896;536594;68800.49596032305;69931.30068699349;70127.64936175286;70605.2939470609;70650;491.53058828818394;494.6809307996322;496.08967544556145;496.18130085359445;496.6994968044281;10260.333078349884;10375.584976601154;10426.530806113895;10538.525766340686;10594.258401911793;33760.62393760604;33796.662033379354;33911.152221194665;34042.14894627654;34048.319033619686;46392.536074638825;46769.064618708115;46823;47280;47511.28733069076;5771.5671324649975;5812.680302583399;5821.883562328814;5830.737616807169;5899.646021238739;9342;11048.337099774039;11372.43137843088;11464.426778660867;11524.827127592926;8407.663693452194;8649.178328058824;9453.101955314234;9717.07687769689;9750.122488975743;9244.722658320261;9419.293552983416;9422.62309507612;9427;9482.478463684563;9431.669891553762;9434.575444104894;9890.060444257784;9996.850047249443;10030.247731420319;5922.703864806656;5951.672658003851;5990.730417131327;6034.366391529002;6042.335343112342;9556.61773529051;9586.95206523963;9639.71080867575;9780.706578802647;9782.902170978485 23:48:50 INFO - 2015-11-24 23:48:50,639 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1171.4494187731773;1630.4049022106933;1688.6116193275545;1715.476779582227;1743.9247295718094;6593.604383736979;7303.123625164981;7387.889181662279;7393.852122957537;7397.075365579302;7212.639368031603;7299.963500182492;7331.816704582388;7333.083364579427;7362.042934418518;1822.6445843060608;1830.8077651846563;2011.5474018345901;2073.419442556079;2098.842586805988;2084.3121769815925;2092.9581408371823;2099.2862426774896;2100.59038487495;2115.9788402115937;2021.5451523407262;2042.1831267493048;2067.5554755727517;2080.573482436097;2089.5716378142442;1999.6700544410155;2032.034783477851;2064.4941989212666;2092.142221689108;2098.8635738677012;2096.507320779631;2118.120979793384;2119.98940005299;2120.703101565782;2122.352682431858;7316;7335.816604584875;7354.926450735531;7358.889616655754;7422.146453157902;4452.844150454718;4479.59683628475;4480.103979204172;4482.753448560328;4568.817247310104;2389.784919357249;2585.8448493090286;2733.630959820419;2737.438825040862;2768.211059847954;765.1850778920488;800.7637746864631;831.1729828820362;835.2941764209294;851.4763420496412;9782.902170978341;9875.703728888146;9889.75275618108;9894.158996485306;9932.90067099327;3950.051987523031;4011.29802284599;4029.697772667003;4061.7156799023783;4064.04494943688;8349.582520873932;8359.498430094214;8360;8378.413511054168;8381.161883811692;4489.461264648263;4492.0791237796175;4500.099980003947;4500.482444518857;4517.5482451755215;4105.58944105587;4114.547399786021;4116.217918595517;4142.46148000758;4144.067584793397;3501.299740052;3502.9824850876093;3541.026217790128;3544.149404142987;3551.982240088783;1109.9944500277447;1117.664700589836;1120.506976930148;1130.9943450282697;1136.2330426961769;717.5694583250008;733.4096052677539;739.4306384084225;742.4320394897908;743.1490942870491;6530.967345163243;6574.145361103122;6574.408303252634;6582.539222254492;6680.565763225375;406.5467004290254;411.9485064366954;416.57509340472546;417.54696154671916;431.78626579843177;4777.689450185727;4847.684900481458;4927.531884471041;4940.407151141886;4956.157453232959;8374.790630234293;8517.787055323666;8597.828043439096;8661.566921653892;8663.393562450568;8559;8563.272121869586;8563.743087707378;8568.22885940256;8581.442206256574;6786.253512113663;6859.039734437183;6859.142607174103;6890.10428644273;6910.412614927687;6931.514793964374;6938.791836244921;6947.861042779015;6966.303369662993;6976.860462790817;7728.45900786962;7865.410094243069;7885.526868387915;7942.046954365514;8012.919870801217;7874.527528348317;8004.759857204293;8141.307988821017;8143.42995990275;8147.429679922348;6512.804615861532;6523.478121750343;6591.143151390289;6595.406413422623;6618.536702430783;6457.773977910751;6552.3447655236005;6562.77030303937;6588.571742836701;6621.966890165519;6573.211214654272;6620.8344791380605;6638.468922486286;6723.428508576826;6792.21889482696;6421.229452465547;6495.870082598416;6500;6585.143931289093;6608.537402381787;6094.238220222473;6128.571000030133;6142.416470435302;6149.84625384369;6161.537884658758;5639.210510528611;5702.914456283076;5716.228309178207;5738.454846789548;5743.62666426681;4872.975635121802;5625.690587017753;5658.122990936411;5659.9151012735665;5712.571557133148 23:48:50 INFO - 2015-11-24 23:48:50,641 DEBUG : BROWSER_OUTPUT: |4;prototype.html;274.1241732664138;283.34971241001904;298.9715976982187;313.3154058382436;314.32577122073167;5554.444555544444;5569.331680198372;5594.188842617818;5634.098544232924;5683.147527870821;5346.385165705945;5467.589930755189;5476.4249753775775;5574.10814269717;5575.080111781562;4365.825366985317;4403.7798110094445;4424.40270563473;4434.224010798113;4457.130859482402;4259.2546304396765;4433.401490798749;4436.179306828231;4459.665525085616;4475.28395456727;4313.633341166004;4333.2200203963275;4390.385346051556;4420.1159768046355;4451.310046942729;4328.350747387885;4397.31841564558;4405.0969551241915;4417.359482874966;4427.092446048552;3822.4648549203134;3824.235152969389;3829.7319187656876;3832.9616703832885;3839.731218814684;5325.680459172462;5412.9458705412835;5430.83707488776;5448.019356515825;5452.991196628596;4657.743824089674;4708.764561771898;4717.834875779331;4738.2892566115015;4750.382450281441;5824.271966004249;5839;5846.473817356416;5854.238948936653;5893.852653683649;3854.614538546151;3861.2663593917064;3864.632859878307;3865.3042452358563;3875;6061.757529698851;6069.453749162552;6130.111133885562;6134;6219.626822390671;4023;4055;4066.024154203029;4075.572064933199;4098.016476045787;4123.793810309532;4126.8238552012535;4150.439690641725;4153.314703074019;4159.812808423628;4790.473047964721;4793.209120495149;4803.543663351976;4807.759612019385;4826.396700412449;5778.595498315161;5863.970680146572;5873.735681894325;5931.762729490858;5955.315138759098;1459.569427019032;1501.481988713892;1502.0386952350505;1505.0819000409742;1505.954821355361;953.2659851913987;958.2669258017622;972.0571046085286;981.6711401680517;984.5372674842812;5692.829215123553;5716.714164291769;5721.885562288731;5770.653760774367;5783.190353350535;6155.322914479404;6162.7226774795245;6165.815025549241;6205;6236.812895613139;5511.889762204813;5575.860603484945;5604.85987850307;5675;5716.142578613241;3354.194993201663;3367.747418943589;3381.239221175216;3394.1514621344663;3398.218409765768;6119.388061193845;6137.294211165773;6144.8771024579255;6159.722812473449;6168.475679567197;6012.909806352908;6231.660193058514;6251.156093927352;6268.49852011838;6288.465480434214;6195.628262304276;6206.751729930752;6210.658413787375;6226.40849119333;6309.242890853127;6163.35284795108;6184.412480814495;6206.162168107428;6257.906131407942;6266.843328916813;5876.764929402776;6100.2984656763265;6108.992016317436;6135.84660383494;6157.415045570664;6188.350223226496;6204.441600255998;6231.906521402273;6271.247450305992;6287.874242515216;3980.144268982183;3983.382575700771;3988.1824226033013;3991.8203680833853;3996.300647386754;5991.940080599138;6166.1983942087245;6171.6297022178815;6183.196184495987;6209.906851397142;5921.3782552831335;6019.006863867413;6025.216721826135;6032.185654936703;6050.092486127116;5974.2830860297045;5981.461668449686;5994.490468310242;6002.789902353396;6006.699665016644;5837;5861.472467477777;5861.6189947653265;5881.059030555261;5881.588288819741;5837.591368604157;5933.940660593512;5937.524998000236;5940.079287710412;5962.791302304398;5789.478946894799;5811.389804070512;5817.709114544171;5844.415558444121;5851.034579294369 23:48:50 INFO - 2015-11-24 23:48:50,642 DEBUG : BROWSER_OUTPUT: |5;yui.html;627.0969803482988;653.9699972543245;673.1551902362536;695.9977632209618;736.6390468670353;12879.356032198388;13083.411246493906;13265.27041012744;13293.335333233348;13297.800532992002;12137.939310303436;12245.265284082961;12246.387680615955;12294.446749896253;12310.015198784098;668.8996650502415;684.7637565040053;844.4553263145268;868.0494858130337;869.2654706772767;853.1255463150289;857.5712143928037;868.8531138896659;869.3697069624503;869.9217070463657;895.5701263393543;898.7258886039755;902.4855832175663;903.7062954539768;905.8369493491169;724.7499612633633;728.8396552758385;881.5900606218139;898.7618281155499;899.4468401932797;665.0722242471774;665.2216906219735;666.040901102411;666.1573110015834;666.2338310942455;12984.350782460933;13187.802182967167;13256.867431325756;13290.800637990438;13307.268100254481;11066.778664426747;11091.33451992883;11158.944205279004;11227.494762735696;11420.88579114215;8695.347848911357;8781.956090219572;9152.17630413266;9186.356955013152;9211.585478653476;3091.2426455518316;3122.9063128106195;3160.8261545614982;3175.3173067790535;3221.1463962049843;47009;47060.05879882383;47080.29379559309;47115.52884471146;47840;8205.179482051746;8233.259006689306;8246.257836794717;8269.21442462965;8652.78368040804;17807.287708491516;17946.461606151835;18029.909850450666;18044.458666240032;18251.361202357853;6507.511936604679;6681.498887583451;6682.732690692415;6783.694733736895;6961.40828029613;3376.611689655721;3598.1544337080763;3610.9277814443562;3611.602723700391;3681.6134305897494;2715.5383584790634;2749;2754.4353407551403;2758.1863350311705;2761.5995680626597;368.85614610302;388.0879932159403;391.16291136966913;391.25856501928683;396.5875489490897;480.3597250559647;480.5218807286772;508.16914345045376;520.476920694707;525.225292693282;6496.415322620986;6666.400023997767;6667.695324749027;6695.665216739144;6741.460683145337;460.27047130298183;490.4090570862103;497.6889444097439;509.21072337876143;533.5704757670035;3237.7813951641383;3239.72462340699;3337.2324365396094;3369.629340772513;3630.5824830144343;53484.46515534873;53812.46187538153;54479;54481.727591362585;55043.44956550383;50345.24482132771;50850.49149508458;50921;50982.74508627507;51019.744901275255;44493.777531112784;44714.77642611701;46029.07941841144;46988.29517557239;47352.28971565429;7549.2073332299315;7602.657880395506;7718.459707820399;7802.72690455854;7898;33100.1724956878;33566.66433335733;33682.66317336795;33710;33719.15702107467;43831.561684382745;46292.53707463017;46718.53281467142;46718.53281467278;47835.521644783104;7054.224035356004;7471.551706897603;7508.249175082667;7527.887081693889;7653.119891212582;10318.329308594917;10406.115480183966;10807.891921080689;10815.567377305135;11565.132615054074;9684.51577421112;9718.173955213886;9840.557174927002;9853.753656158367;9880.654177103766;10071.798564028531;10088.092071713581;10112.696619101438;10118;10186.286959912735;9546.284028697737;9640.90359096428;9681.70954871355;9697;9809.509524523888;8748.69379571712;8930.86603700958;8986.730398088068;8997.37018408705;9158.816823663623;7400.5189662671755;8288.58557072156;8417.158284171534;8449.45078569891;8465.238128568211 23:48:50 INFO - 2015-11-24 23:48:50,642 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:48:50 INFO - 2015-11-24 23:48:50,642 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:48:50 INFO - 2015-11-24 23:48:50,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,935 23:48:50 INFO - 2015-11-24 23:48:50,643 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:48:50 INFO - 2015-11-24 23:48:50,643 DEBUG : BROWSER_OUTPUT: __startTimestamp1448437730629__endTimestamp 23:48:50 INFO - 2015-11-24 23:48:50,643 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,644 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5041.90 Median:5183.40 stddev:526.18 (10.2%) stddev-sans-first:502.53 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: Values: 2988.7 3008.2 3029.7 3039.1 3168.0 5070.6 5090.5 5092.1 5097.5 5133.8 5081.7 5088.4 5091.4 5208.5 5220.3 4671.7 4736.9 4765.3 4777.3 4806.7 4801.1 4818.8 4821.1 4828.8 4863.4 4710.1 4821.4 4831.4 4834.5 4836.6 4706.8 4842.1 4847.7 4872.8 5019.2 4711.5 4737.1 4751.6 4760.2 4809.1 4928.2 4955.5 5003.5 5077.3 5081.0 5436.0 5442.3 5453.5 5461.9 5470.2 5473.8 5536.2 5541.2 5551.5 5562.4 4863.5 4980.9 4991.7 5090.5 5099.8 5461.2 5475.4 5479.0 5489.1 5511.9 5253.4 5269.0 5276.1 5280.2 5334.5 5323.5 5338.0 5405.9 5425.2 5445.1 5292.8 5404.8 5412.2 5423.2 5465.3 5451.3 5456.9 5457.0 5486.4 5535.3 3988.4 4013.4 4095.3 4107.0 4175.2 3715.8 3715.9 3725.0 3726.7 3755.1 5047.1 5054.3 5062.4 5083.8 5106.5 5169.1 5323.1 5423.5 5443.8 5454.4 5000.3 5125.3 5142.1 5180.0 5183.4 4645.1 4790.2 4800.8 4812.4 4882.8 5281.6 5329.2 5432.8 5447.3 5523.9 5352.8 5381.7 5405.1 5406.3 5442.5 5369.5 5383.6 5404.5 5462.9 5469.8 5162.1 5261.2 5293.6 5323.8 5342.7 5313.3 5343.0 5360.3 5372.5 5419.6 5180.8 5200.9 5251.9 5279.7 5304.0 5101.1 5162.1 5199.9 5251.1 5345.4 5155.3 5164.3 5200.5 5203.8 5319.6 5276.3 5291.2 5305.1 5314.3 5324.7 4869.9 4987.3 5152.4 5235.2 5257.5 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,645 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43355.35 Median:30168.75 stddev:70650.07 (234.2%) stddev-sans-first:70775.08 23:48:50 INFO - 2015-11-24 23:48:50,647 DEBUG : BROWSER_OUTPUT: Values: 526.7 527.6 534.0 544.6 559.5 29997.3 31407.0 36881.4 37469.4 37943.0 41322.8 41547.4 41992.8 42053.0 42097.4 8075.2 8509.4 8703.3 8793.2 8796.5 8035.1 10301.3 10499.3 10656.5 10697.0 10241.3 10373.4 10411.8 10534.2 10536.9 8203.8 8327.6 10262.4 10284.2 10312.9 10162.2 10190.3 10236.9 10244.4 10320.9 37684.4 38149.0 38202.4 38255.6 38596.4 2874.8 2889.3 2895.0 3407.9 3410.2 25961.9 25965.0 26725.3 26932.5 27114.3 2136.0 2147.2 2205.3 2237.6 2293.8 269335.0 270908.0 271027.0 271485.0 271952.0 55234.7 56424.7 63502.4 64625.7 65512.3 59221.4 59769.0 59913.1 60532.4 60542.4 15762.7 16068.3 16088.8 16099.6 16130.7 11970.8 12191.9 12231.5 12369.4 12429.7 19071.6 19385.8 19481.1 19495.9 19578.3 7682.3 7888.4 7892.8 7894.7 7970.7 820.5 937.9 992.2 1037.4 1088.1 27814.9 27824.7 27929.9 28118.7 30151.4 923.2 1026.8 1045.8 1104.2 1136.1 13970.2 14176.6 14403.0 14514.3 14523.1 321738.0 321886.0 322080.0 322092.0 326260.0 45286.1 46122.8 46285.3 52436.2 52779.5 1313.9 1338.9 1350.9 1361.7 1363.3 25476.5 25618.5 26138.2 28018.6 28803.7 44183.3 45451.8 45588.5 51355.0 52221.0 197948.0 199451.0 204690.0 206819.0 207123.0 29072.7 29396.1 30186.1 30483.5 30496.8 37505.6 39966.4 40036.6 42026.2 42103.6 33308.0 33799.8 35086.1 35187.5 35479.1 31430.5 31594.4 32033.2 32060.5 32227.0 31980.7 32214.5 32731.7 32852.0 33043.5 28132.7 30099.2 30222.4 30279.5 30561.4 22897.9 23040.3 23062.0 23157.9 23219.4 23:48:50 INFO - 2015-11-24 23:48:50,647 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,647 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27692.63 Median:525372.00 stddev:85943.19 (16.4%) stddev-sans-first:86159.71 23:48:50 INFO - 2015-11-24 23:48:50,648 DEBUG : BROWSER_OUTPUT: Values: 322.4 326.5 328.1 328.5 337.9 14088.2 14377.4 16036.8 16713.8 17232.8 14071.9 15186.3 18394.8 18412.0 18891.9 5407.9 5660.9 5679.0 5743.1 5755.0 4126.5 4276.0 5516.9 5610.6 6173.0 6353.8 6372.1 6415.0 6415.0 6437.4 6281.4 6306.3 6338.4 6342.6 6407.1 5916.5 6076.3 6105.7 6123.3 6145.5 22258.1 23309.8 23358.9 23376.5 23986.2 1804.5 1966.5 1996.2 1998.6 2148.4 13477.5 13691.0 13855.2 14311.8 14381.2 1665.2 1739.6 1757.1 1758.4 1763.1 55195.7 57797.7 58544.0 61302.0 64435.7 16189.2 16758.2 16768.2 16815.5 17009.8 23473.2 23483.9 24206.9 24289.1 24403.5 9274.1 9486.7 9502.1 9548.1 9556.8 7962.2 8004.3 8055.5 8060.3 8068.9 7891.9 7933.8 7936.9 7937.4 7971.8 992.8 999.8 1004.1 2054.0 3118.8 408.2 417.2 428.4 433.9 438.9 9582.4 10402.4 10641.5 10987.2 11027.0 441.7 449.0 453.8 459.8 463.5 5864.0 6035.9 6045.5 6062.7 6184.0 513487.0 522956.0 527788.0 529896.0 536594.0 68800.5 69931.3 70127.6 70605.3 70650.0 491.5 494.7 496.1 496.2 496.7 10260.3 10375.6 10426.5 10538.5 10594.3 33760.6 33796.7 33911.2 34042.1 34048.3 46392.5 46769.1 46823.0 47280.0 47511.3 5771.6 5812.7 5821.9 5830.7 5899.6 9342.0 11048.3 11372.4 11464.4 11524.8 8407.7 8649.2 9453.1 9717.1 9750.1 9244.7 9419.3 9422.6 9427.0 9482.5 9431.7 9434.6 9890.1 9996.9 10030.2 5922.7 5951.7 5990.7 6034.4 6042.3 9556.6 9587.0 9639.7 9780.7 9782.9 23:48:50 INFO - 2015-11-24 23:48:50,649 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,649 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5012.55 Median:6439.50 stddev:2657.03 (41.3%) stddev-sans-first:2648.80 23:48:50 INFO - 2015-11-24 23:48:50,650 DEBUG : BROWSER_OUTPUT: Values: 1171.4 1630.4 1688.6 1715.5 1743.9 6593.6 7303.1 7387.9 7393.9 7397.1 7212.6 7300.0 7331.8 7333.1 7362.0 1822.6 1830.8 2011.5 2073.4 2098.8 2084.3 2093.0 2099.3 2100.6 2116.0 2021.5 2042.2 2067.6 2080.6 2089.6 1999.7 2032.0 2064.5 2092.1 2098.9 2096.5 2118.1 2120.0 2120.7 2122.4 7316.0 7335.8 7354.9 7358.9 7422.1 4452.8 4479.6 4480.1 4482.8 4568.8 2389.8 2585.8 2733.6 2737.4 2768.2 765.2 800.8 831.2 835.3 851.5 9782.9 9875.7 9889.8 9894.2 9932.9 3950.1 4011.3 4029.7 4061.7 4064.0 8349.6 8359.5 8360.0 8378.4 8381.2 4489.5 4492.1 4500.1 4500.5 4517.5 4105.6 4114.5 4116.2 4142.5 4144.1 3501.3 3503.0 3541.0 3544.1 3552.0 1110.0 1117.7 1120.5 1131.0 1136.2 717.6 733.4 739.4 742.4 743.1 6531.0 6574.1 6574.4 6582.5 6680.6 406.5 411.9 416.6 417.5 431.8 4777.7 4847.7 4927.5 4940.4 4956.2 8374.8 8517.8 8597.8 8661.6 8663.4 8559.0 8563.3 8563.7 8568.2 8581.4 6786.3 6859.0 6859.1 6890.1 6910.4 6931.5 6938.8 6947.9 6966.3 6976.9 7728.5 7865.4 7885.5 7942.0 8012.9 7874.5 8004.8 8141.3 8143.4 8147.4 6512.8 6523.5 6591.1 6595.4 6618.5 6457.8 6552.3 6562.8 6588.6 6622.0 6573.2 6620.8 6638.5 6723.4 6792.2 6421.2 6495.9 6500.0 6585.1 6608.5 6094.2 6128.6 6142.4 6149.8 6161.5 5639.2 5702.9 5716.2 5738.5 5743.6 4873.0 5625.7 5658.1 5659.9 5712.6 23:48:50 INFO - 2015-11-24 23:48:50,650 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,650 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4942.45 Median:5716.43 stddev:1494.80 (26.1%) stddev-sans-first:1457.35 23:48:50 INFO - 2015-11-24 23:48:50,652 DEBUG : BROWSER_OUTPUT: Values: 274.1 283.3 299.0 313.3 314.3 5554.4 5569.3 5594.2 5634.1 5683.1 5346.4 5467.6 5476.4 5574.1 5575.1 4365.8 4403.8 4424.4 4434.2 4457.1 4259.3 4433.4 4436.2 4459.7 4475.3 4313.6 4333.2 4390.4 4420.1 4451.3 4328.4 4397.3 4405.1 4417.4 4427.1 3822.5 3824.2 3829.7 3833.0 3839.7 5325.7 5412.9 5430.8 5448.0 5453.0 4657.7 4708.8 4717.8 4738.3 4750.4 5824.3 5839.0 5846.5 5854.2 5893.9 3854.6 3861.3 3864.6 3865.3 3875.0 6061.8 6069.5 6130.1 6134.0 6219.6 4023.0 4055.0 4066.0 4075.6 4098.0 4123.8 4126.8 4150.4 4153.3 4159.8 4790.5 4793.2 4803.5 4807.8 4826.4 5778.6 5864.0 5873.7 5931.8 5955.3 1459.6 1501.5 1502.0 1505.1 1506.0 953.3 958.3 972.1 981.7 984.5 5692.8 5716.7 5721.9 5770.7 5783.2 6155.3 6162.7 6165.8 6205.0 6236.8 5511.9 5575.9 5604.9 5675.0 5716.1 3354.2 3367.7 3381.2 3394.2 3398.2 6119.4 6137.3 6144.9 6159.7 6168.5 6012.9 6231.7 6251.2 6268.5 6288.5 6195.6 6206.8 6210.7 6226.4 6309.2 6163.4 6184.4 6206.2 6257.9 6266.8 5876.8 6100.3 6109.0 6135.8 6157.4 6188.4 6204.4 6231.9 6271.2 6287.9 3980.1 3983.4 3988.2 3991.8 3996.3 5991.9 6166.2 6171.6 6183.2 6209.9 5921.4 6019.0 6025.2 6032.2 6050.1 5974.3 5981.5 5994.5 6002.8 6006.7 5837.0 5861.5 5861.6 5881.1 5881.6 5837.6 5933.9 5937.5 5940.1 5962.8 5789.5 5811.4 5817.7 5844.4 5851.0 23:48:50 INFO - 2015-11-24 23:48:50,652 DEBUG : BROWSER_OUTPUT: 23:48:50 INFO - 2015-11-24 23:48:50,652 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13006.39 Median:51001.24 stddev:15812.66 (31.0%) stddev-sans-first:15829.70 23:48:50 INFO - 2015-11-24 23:48:50,653 DEBUG : BROWSER_OUTPUT: Values: 627.1 654.0 673.2 696.0 736.6 12879.4 13083.4 13265.3 13293.3 13297.8 12137.9 12245.3 12246.4 12294.4 12310.0 668.9 684.8 844.5 868.0 869.3 853.1 857.6 868.9 869.4 869.9 895.6 898.7 902.5 903.7 905.8 724.7 728.8 881.6 898.8 899.4 665.1 665.2 666.0 666.2 666.2 12984.4 13187.8 13256.9 13290.8 13307.3 11066.8 11091.3 11158.9 11227.5 11420.9 8695.3 8782.0 9152.2 9186.4 9211.6 3091.2 3122.9 3160.8 3175.3 3221.1 47009.0 47060.1 47080.3 47115.5 47840.0 8205.2 8233.3 8246.3 8269.2 8652.8 17807.3 17946.5 18029.9 18044.5 18251.4 6507.5 6681.5 6682.7 6783.7 6961.4 3376.6 3598.2 3610.9 3611.6 3681.6 2715.5 2749.0 2754.4 2758.2 2761.6 368.9 388.1 391.2 391.3 396.6 480.4 480.5 508.2 520.5 525.2 6496.4 6666.4 6667.7 6695.7 6741.5 460.3 490.4 497.7 509.2 533.6 3237.8 3239.7 3337.2 3369.6 3630.6 53484.5 53812.5 54479.0 54481.7 55043.4 50345.2 50850.5 50921.0 50982.7 51019.7 44493.8 44714.8 46029.1 46988.3 47352.3 7549.2 7602.7 7718.5 7802.7 7898.0 33100.2 33566.7 33682.7 33710.0 33719.2 43831.6 46292.5 46718.5 46718.5 47835.5 7054.2 7471.6 7508.2 7527.9 7653.1 10318.3 10406.1 10807.9 10815.6 11565.1 9684.5 9718.2 9840.6 9853.8 9880.7 10071.8 10088.1 10112.7 10118.0 10186.3 9546.3 9640.9 9681.7 9697.0 9809.5 8748.7 8930.9 8986.7 8997.4 9158.8 7400.5 8288.6 8417.2 8449.5 8465.2 23:48:50 INFO - 2015-11-24 23:48:50,653 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:48:50 INFO - 2015-11-24 23:48:50,653 DEBUG : BROWSER_OUTPUT: 23:48:51 INFO - 2015-11-24 23:48:51,071 INFO : Browser exited with error code: 0 23:48:51 INFO - 2015-11-24 23:48:51,101 INFO : Completed test dromaeo_css (00:18:34) 23:48:51 INFO - 2015-11-24 23:48:51,101 INFO : Starting test kraken 23:48:51 INFO - 2015-11-24 23:48:51,101 DEBUG : operating with platform_type : mac_ 23:48:51 INFO - 2015-11-24 23:48:51,101 INFO : Initialising browser for kraken test... 23:48:51 INFO - 2015-11-24 23:48:51,116 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpIAPLe7/profile http://localhost:49270/getInfo.html 23:48:53 INFO - 2015-11-24 23:48:53,578 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:48:53 INFO - 2015-11-24 23:48:53,579 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:48:53 INFO - 2015-11-24 23:48:53,579 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:48:53 INFO - 2015-11-24 23:48:53,579 DEBUG : BROWSER_OUTPUT: __metrics 23:48:53 INFO - 2015-11-24 23:48:53,594 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:48:54 INFO - 2015-11-24 23:48:54,304 INFO : Browser initialized. 23:48:54 INFO - 2015-11-24 23:48:54,304 INFO : Running cycle 1/1 for kraken test... 23:48:54 INFO - 2015-11-24 23:48:54,304 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpIAPLe7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:49:06 INFO - 2015-11-24 23:49:06,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 199745536 23:49:06 INFO - 2015-11-24 23:49:06,241 DEBUG : BROWSER_OUTPUT: 23:49:08 INFO - 2015-11-24 23:49:08,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:09 INFO - 2015-11-24 23:49:09,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 266571776 23:49:09 INFO - 2015-11-24 23:49:09,443 DEBUG : BROWSER_OUTPUT: 23:49:12 INFO - 2015-11-24 23:49:12,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 23:49:12 INFO - 2015-11-24 23:49:12,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 281182208 23:49:12 INFO - 2015-11-24 23:49:12,851 DEBUG : BROWSER_OUTPUT: 23:49:15 INFO - 2015-11-24 23:49:15,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 23:49:16 INFO - 2015-11-24 23:49:16,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 269533184 23:49:16 INFO - 2015-11-24 23:49:16,459 DEBUG : BROWSER_OUTPUT: 23:49:18 INFO - 2015-11-24 23:49:18,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 23:49:19 INFO - 2015-11-24 23:49:19,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 269414400 23:49:19 INFO - 2015-11-24 23:49:19,187 DEBUG : BROWSER_OUTPUT: 23:49:21 INFO - 2015-11-24 23:49:21,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:22 INFO - 2015-11-24 23:49:22,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 270012416 23:49:22 INFO - 2015-11-24 23:49:22,110 DEBUG : BROWSER_OUTPUT: 23:49:25 INFO - 2015-11-24 23:49:25,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:25 INFO - 2015-11-24 23:49:25,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 271065088 23:49:25 INFO - 2015-11-24 23:49:25,985 DEBUG : BROWSER_OUTPUT: 23:49:29 INFO - 2015-11-24 23:49:29,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:29 INFO - 2015-11-24 23:49:29,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 271298560 23:49:29 INFO - 2015-11-24 23:49:29,936 DEBUG : BROWSER_OUTPUT: 23:49:33 INFO - 2015-11-24 23:49:33,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 23:49:33 INFO - 2015-11-24 23:49:33,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 270884864 23:49:33 INFO - 2015-11-24 23:49:33,609 DEBUG : BROWSER_OUTPUT: 23:49:35 INFO - 2015-11-24 23:49:35,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:49:35 INFO - 2015-11-24 23:49:35,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 302133248 23:49:35 INFO - 2015-11-24 23:49:35,850 DEBUG : BROWSER_OUTPUT: 23:49:37 INFO - 2015-11-24 23:49:37,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:49:38 INFO - 2015-11-24 23:49:38,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 302886912 23:49:38 INFO - 2015-11-24 23:49:38,403 DEBUG : BROWSER_OUTPUT: 23:49:40 INFO - 2015-11-24 23:49:40,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:49:41 INFO - 2015-11-24 23:49:41,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 308690944 23:49:41 INFO - 2015-11-24 23:49:41,171 DEBUG : BROWSER_OUTPUT: 23:49:43 INFO - 2015-11-24 23:49:43,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:49:44 INFO - 2015-11-24 23:49:44,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 312799232 23:49:44 INFO - 2015-11-24 23:49:44,512 DEBUG : BROWSER_OUTPUT: 23:49:47 INFO - 2015-11-24 23:49:47,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:49:47 INFO - 2015-11-24 23:49:47,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 309940224 23:49:47 INFO - 2015-11-24 23:49:47,813 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 23:49:49 INFO - 2015-11-24 23:49:49,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 369991680 23:49:49 INFO - 2015-11-24 23:49:49,864 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,865 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;106;108;107;117;114;119;119;112;109 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;143;177;168;140;161;139;175;165;138 23:49:49 INFO - 2015-11-24 23:49:49,866 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;179;180;179;174;172;177;180;179;176 23:49:49 INFO - 2015-11-24 23:49:49,867 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;88;87;131;73;78;79;79;135;73 23:49:49 INFO - 2015-11-24 23:49:49,867 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;106;153;98;101;100;142;97;98;146 23:49:49 INFO - 2015-11-24 23:49:49,867 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;130;135;130;135;125;136;136;135;135 23:49:49 INFO - 2015-11-24 23:49:49,867 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;135;140;140;140;140;141;140;140;140;134 23:49:49 INFO - 2015-11-24 23:49:49,867 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;112;113;113;114;114;116;116;112;114;112 23:49:49 INFO - 2015-11-24 23:49:49,868 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;64;67;68;70;70;70;79;65;64 23:49:49 INFO - 2015-11-24 23:49:49,868 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;70;71;74;76;76;75;84;76;75 23:49:49 INFO - 2015-11-24 23:49:49,868 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;89;91;93;95;97;93;91;91;96 23:49:49 INFO - 2015-11-24 23:49:49,869 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;134;140;138;140;135;140;141;148;137 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;162;160;164;160;160;160;159;159;156 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;72;74;78;78;78;77;78;77;78 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:49:49 INFO - 2015-11-24 23:49:49,870 DEBUG : BROWSER_OUTPUT: __startTimestamp1448437789865__endTimestamp 23:49:49 INFO - 2015-11-24 23:49:49,871 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,871 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:49:49 INFO - 2015-11-24 23:49:49,871 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:49:49 INFO - 2015-11-24 23:49:49,871 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,872 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:4.97 (4.4%) stddev-sans-first:5.15 23:49:49 INFO - 2015-11-24 23:49:49,872 DEBUG : BROWSER_OUTPUT: Values: 109.0 106.0 108.0 107.0 117.0 114.0 119.0 119.0 112.0 109.0 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:157.10 Median:165.00 stddev:15.49 (9.4%) stddev-sans-first:16.16 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: Values: 165.0 143.0 177.0 168.0 140.0 161.0 139.0 175.0 165.0 138.0 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:176.80 Median:179.00 stddev:3.16 (1.8%) stddev-sans-first:2.83 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: Values: 172.0 179.0 180.0 179.0 174.0 172.0 177.0 180.0 179.0 176.0 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,873 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.40 Median:79.00 stddev:23.00 (29.1%) stddev-sans-first:24.15 23:49:49 INFO - 2015-11-24 23:49:49,874 DEBUG : BROWSER_OUTPUT: Values: 81.0 88.0 87.0 131.0 73.0 78.0 79.0 79.0 135.0 73.0 23:49:49 INFO - 2015-11-24 23:49:49,874 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,874 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.50 Median:149.50 stddev:22.75 (15.2%) stddev-sans-first:23.81 23:49:49 INFO - 2015-11-24 23:49:49,874 DEBUG : BROWSER_OUTPUT: Values: 104.0 106.0 153.0 98.0 101.0 100.0 142.0 97.0 98.0 146.0 23:49:49 INFO - 2015-11-24 23:49:49,874 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.30 Median:135.00 stddev:3.71 (2.8%) stddev-sans-first:3.81 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: Values: 136.0 130.0 135.0 130.0 135.0 125.0 136.0 136.0 135.0 135.0 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:139.00 Median:140.00 stddev:2.40 (1.7%) stddev-sans-first:2.07 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: Values: 135.0 140.0 140.0 140.0 140.0 141.0 140.0 140.0 140.0 134.0 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,875 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.60 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:1.48 23:49:49 INFO - 2015-11-24 23:49:49,876 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 113.0 114.0 114.0 116.0 116.0 112.0 114.0 112.0 23:49:49 INFO - 2015-11-24 23:49:49,876 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,876 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.40 Median:69.00 stddev:5.70 (8.3%) stddev-sans-first:4.64 23:49:49 INFO - 2015-11-24 23:49:49,876 DEBUG : BROWSER_OUTPUT: Values: 57.0 64.0 67.0 68.0 70.0 70.0 70.0 79.0 65.0 64.0 23:49:49 INFO - 2015-11-24 23:49:49,876 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:75.50 stddev:4.55 (6.0%) stddev-sans-first:3.96 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 71.0 74.0 76.0 76.0 75.0 84.0 76.0 75.0 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:93.00 stddev:3.33 (3.6%) stddev-sans-first:2.67 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: Values: 86.0 89.0 91.0 93.0 95.0 97.0 93.0 91.0 91.0 96.0 23:49:49 INFO - 2015-11-24 23:49:49,877 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,878 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:140.00 stddev:4.83 (3.5%) stddev-sans-first:4.09 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: Values: 130.0 134.0 140.0 138.0 140.0 135.0 140.0 141.0 148.0 137.0 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:3.26 (2.0%) stddev-sans-first:2.18 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: Values: 152.0 162.0 160.0 164.0 160.0 160.0 160.0 159.0 159.0 156.0 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:78.00 stddev:3.43 (4.4%) stddev-sans-first:2.18 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 74.0 78.0 78.0 78.0 77.0 78.0 77.0 78.0 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:49:49 INFO - 2015-11-24 23:49:49,879 DEBUG : BROWSER_OUTPUT: 23:49:50 INFO - 2015-11-24 23:49:50,532 INFO : Browser exited with error code: 0 23:49:50 INFO - 2015-11-24 23:49:50,586 INFO : Completed test kraken (00:00:59) 23:49:50 INFO - 2015-11-24 23:49:50,586 INFO : Starting test v8_7 23:49:50 INFO - 2015-11-24 23:49:50,586 DEBUG : operating with platform_type : mac_ 23:49:50 INFO - 2015-11-24 23:49:50,586 INFO : Initialising browser for v8_7 test... 23:49:50 INFO - 2015-11-24 23:49:50,600 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpe_GzmT/profile http://localhost:49270/getInfo.html 23:49:52 INFO - 2015-11-24 23:49:52,925 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:49:52 INFO - 2015-11-24 23:49:52,925 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:49:52 INFO - 2015-11-24 23:49:52,926 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:49:52 INFO - 2015-11-24 23:49:52,926 DEBUG : BROWSER_OUTPUT: __metrics 23:49:52 INFO - 2015-11-24 23:49:52,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:49:53 INFO - 2015-11-24 23:49:53,645 INFO : Browser initialized. 23:49:53 INFO - 2015-11-24 23:49:53,645 INFO : Running cycle 1/1 for v8_7 test... 23:49:53 INFO - 2015-11-24 23:49:53,645 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/T/tmpe_GzmT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:50:05 INFO - 2015-11-24 23:50:05,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 200224768 23:50:05 INFO - 2015-11-24 23:50:05,594 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 569315328 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: |0;Richards;176.0253476500616 23:50:27 INFO - 2015-11-24 23:50:27,354 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;204.08163265306123 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |2;Encrypt;354.86160397444996 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6320.754716981132 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1121.0762331838564 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |5;Earley;753.5795026375282 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |6;Boyer;13863.013698630137 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |7;RegExp;32000 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |8;Splay;720.9805335255949 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6308.176100628931 23:50:27 INFO - 2015-11-24 23:50:27,355 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: __startTimestamp1448437827349__endTimestamp 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.03 Median:176.03 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: Values: 176.0 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,356 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:204.08 Median:204.08 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: Values: 204.1 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:354.86 Median:354.86 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: Values: 354.9 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6320.75 Median:6320.75 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: Values: 6320.8 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,357 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: Values: 1121.1 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:753.58 Median:753.58 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: Values: 753.6 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13863.01 Median:13863.01 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: Values: 13863.0 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32000.00 Median:32000.00 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: Values: 32000.0 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: Values: 721.0 23:50:27 INFO - 2015-11-24 23:50:27,358 DEBUG : BROWSER_OUTPUT: 23:50:27 INFO - 2015-11-24 23:50:27,359 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6308.18 Median:6308.18 stddev:0.00 (0.0%) 23:50:27 INFO - 2015-11-24 23:50:27,359 DEBUG : BROWSER_OUTPUT: Values: 6308.2 23:50:27 INFO - 2015-11-24 23:50:27,359 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:50:27 INFO - 2015-11-24 23:50:27,359 DEBUG : BROWSER_OUTPUT: 23:50:28 INFO - 2015-11-24 23:50:28,051 INFO : Browser exited with error code: 0 23:50:28 INFO - 2015-11-24 23:50:28,074 INFO : Completed test v8_7 (00:00:37) 23:50:28 INFO - 2015-11-24 23:50:28,444 INFO : Completed test suite (00:20:11) 23:50:28 INFO - 2015-11-24 23:50:28,444 DEBUG : Working with test: dromaeo_css 23:50:28 INFO - 2015-11-24 23:50:28,444 DEBUG : Generating results file: dromaeo_css 23:50:28 INFO - 2015-11-24 23:50:28,445 DEBUG : Working with test: kraken 23:50:28 INFO - 2015-11-24 23:50:28,445 DEBUG : Generating results file: kraken 23:50:28 INFO - 2015-11-24 23:50:28,445 INFO : javascript benchmark 23:50:28 INFO - 2015-11-24 23:50:28,445 DEBUG : Working with test: v8_7 23:50:28 INFO - 2015-11-24 23:50:28,445 DEBUG : Generating results file: v8_7 23:50:28 INFO - 2015-11-24 23:50:28,446 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:28 INFO - 2015-11-24 23:50:28,498 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 23:50:28 INFO - 2015-11-24 23:50:28,498 DEBUG : process_Request line: dromaeo_css 6429.12 graph.html#tests=[[72,52,55]] 23:50:28 INFO - 2015-11-24 23:50:28,498 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:28 INFO - 2015-11-24 23:50:28,618 DEBUG : process_Request line: kraken 1644.00 graph.html#tests=[[232,52,55]] 23:50:28 INFO - 2015-11-24 23:50:28,618 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:28 INFO - 2015-11-24 23:50:28,747 DEBUG : process_Request line: v8_7 18454.61 graph.html#tests=[[230,52,55]] 23:50:28 INFO - 2015-11-24 23:50:28,748 INFO : javascript benchmark 23:50:28 INFO - 2015-11-24 23:50:28,750 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [322.43412810517555, 326.5428400239664, 328.06828606756807, 328.5285615142271, 337.9273456206915, 14088.225147616877, 14377.424903003894, 16036.75944860828, 16713.83003189777, 17232.82767172328, 14071.92964035181, 15186.31661575229, 18394.816051839476, 18412.0, 18891.90554047228, 5407.918881216785, 5660.858478538049, 5679.034564124109, 5743.081107022877, 5754.971225143869, 4126.504819421673, 4276.016516201275, 5516.889662206753, 5610.579206559504, 6173.0, 6353.777617783378, 6372.107904893319, 6414.9679251603675, 6414.9679251603675, 6437.388448097447, 6281.371862813728, 6306.274778400497, 6338.397852204056, 6342.619442833445, 6407.103005579223, 5916.526677865761, 6076.270847498285, 6105.664188469633, 6123.295820980599, 6145.477634401082, 22258.109675612955, 23309.766902330928, 23358.883205584032, 23376.53246935069, 23986.160484383137, 1804.5398423401948, 1966.547694030381, 1996.2114964588907, 1998.590288990768, 2148.387709502784, 13477.528286509925, 13691.0, 13855.237961912091, 14311.78532322016, 14381.209033503153, 1665.225670063414, 1739.6346767178907, 1757.0775342944928, 1758.4460894818092, 1763.0920076160787, 55195.72402137964, 57797.71101144468, 58544.0, 61301.999999999556, 64435.67782161106, 16189.19054047293, 16758.24587893548, 16768.245428955724, 16815.495535133967, 17009.829901700825, 23473.178438754563, 23483.88258058699, 24206.878965605058, 24289.149879754124, 24403.511929761306, 9274.118958698913, 9486.715398538056, 9502.052079323723, 9548.092931171528, 9556.808863822685, 7962.163972782774, 8004.319632831274, 8055.516668999761, 8060.314873235723, 8068.919310806934, 7891.881621775678, 7933.761987140395, 7936.920630793734, 7937.3650107991225, 7971.800704982305, 992.8009459048243, 999.7750506136061, 1004.1163775877181, 2054.0243384392293, 3118.781685282054, 408.2386349458239, 417.21771678103556, 428.3617410059052, 433.87417648882104, 438.87053319270893, 9582.377145485521, 10402.427866467266, 10641.467926603638, 10987.230893837515, 11027.0, 441.7062653335496, 448.9797959091849, 453.8411555955455, 459.8413547326167, 463.48321621391904, 5864.0031194697, 6035.8792824143275, 6045.486133678686, 6062.696865156725, 6183.979643358885, 513487.0, 522956.0, 527788.0, 529896.0, 536594.0, 68800.49596032305, 69931.30068699349, 70127.64936175286, 70605.2939470609, 70650.0, 491.53058828818394, 494.6809307996322, 496.08967544556145, 496.18130085359445, 496.6994968044281, 10260.333078349884, 10375.584976601154, 10426.530806113895, 10538.525766340686, 10594.258401911793, 33760.62393760604, 33796.662033379354, 33911.152221194665, 34042.14894627654, 34048.319033619686, 46392.536074638825, 46769.064618708115, 46823.0, 47280.0, 47511.28733069076, 5771.5671324649975, 5812.680302583399, 5821.883562328814, 5830.737616807169, 5899.646021238739, 9342.0, 11048.337099774039, 11372.43137843088, 11464.426778660867, 11524.827127592926, 8407.663693452194, 8649.178328058824, 9453.101955314234, 9717.07687769689, 9750.122488975743, 9244.722658320261, 9419.293552983416, 9422.62309507612, 9427.0, 9482.478463684563, 9431.669891553762, 9434.575444104894, 9890.060444257784, 9996.850047249443, 10030.247731420319, 5922.703864806656, 5951.672658003851, 5990.730417131327, 6034.366391529002, 6042.335343112342, 9556.61773529051, 9586.95206523963, 9639.71080867575, 9780.706578802647, 9782.902170978485], "dojo.html": [2988.656304524979, 3008.1577158395658, 3029.742471889889, 3039.0578920534645, 3168.0, 5070.569001634865, 5090.516400941905, 5092.108880945833, 5097.464766199542, 5133.82031628893, 5081.6696914700515, 5088.389393272803, 5091.363579552556, 5208.453112423198, 5220.269162317279, 4671.743054132022, 4736.928946065812, 4765.332853400527, 4777.3072904428755, 4806.663533552653, 4801.135795556798, 4818.7831547580445, 4821.083994041139, 4828.806847726087, 4863.416390033201, 4710.057988402316, 4821.421429428474, 4831.396075490564, 4834.540718631724, 4836.613070954333, 4706.788194531271, 4842.080004799077, 4847.684900481493, 4872.829450969234, 5019.196928491424, 4711.505291944331, 4737.099951009297, 4751.596114330286, 4760.166970780099, 4809.1343558159515, 4928.186849169882, 4955.479674634147, 5003.474635163292, 5077.289179514871, 5081.0, 5435.9943410468795, 5442.346918369782, 5453.481919217668, 5461.890762184774, 5470.234167216593, 5473.808416705396, 5536.197251398525, 5541.196526503675, 5551.472610102074, 5562.415946325618, 4863.489333619955, 4980.850574482772, 4991.725455100004, 5090.49095090488, 5099.796008159669, 5461.15352120422, 5475.425080366584, 5478.986387518322, 5489.1217405215775, 5511.862203444946, 5253.44838791929, 5269.0252303324005, 5276.07668657991, 5280.155175171954, 5334.546563542065, 5323.494268044529, 5338.012467693489, 5405.891882162335, 5425.159100339453, 5445.128779395278, 5292.761825717852, 5404.83785486436, 5412.188171774265, 5423.240746295522, 5465.289512363367, 5451.318585176853, 5456.91814622781, 5457.045017121988, 5486.423925487767, 5535.252740880011, 3988.3618621020496, 4013.4381186633896, 4095.28332541804, 4107.034846810997, 4175.227582897113, 3715.777053376806, 3715.851365945332, 3724.9942515521197, 3726.6832319253167, 3755.1363186467265, 5047.091523525801, 5054.292399064134, 5062.417821950523, 5083.822066227664, 5106.463821298785, 5169.121249387613, 5323.148296272578, 5423.511883930465, 5443.755031023535, 5454.427285135083, 5000.274960130833, 5125.308083408767, 5142.100132476801, 5180.0416922868635, 5183.403908550565, 4645.094206629675, 4790.185668436374, 4800.807967681254, 4812.446568644581, 4882.829100981519, 5281.60387970896, 5329.227262046981, 5432.837014889559, 5447.291852059207, 5523.944760552424, 5352.785888564569, 5381.650192737459, 5405.081136206775, 5406.324209473816, 5442.537384322377, 5369.4630536946, 5383.569314454756, 5404.459554044564, 5462.8907421850545, 5469.781208751605, 5162.09663308912, 5261.237120617566, 5293.602979776455, 5323.813666521653, 5342.679439233659, 5313.335833020872, 5342.973285133705, 5360.276362691143, 5372.5433338166695, 5419.647722897999, 5180.792768289226, 5200.947990520046, 5251.894962100813, 5279.683219006872, 5304.045271851104, 5101.0818052750865, 5162.148245539444, 5199.870003249949, 5251.054810134213, 5345.358556973188, 5155.252488389087, 5164.302819119371, 5200.5059519345605, 5203.765830537711, 5319.601029922694, 5276.314079169837, 5291.1798671206025, 5305.071612467726, 5314.28257185275, 5324.733763311741, 4869.926951095807, 4987.2768448574025, 5152.355955505562, 5235.1623740201385, 5257.4742525747115], "mootools.html": [1171.4494187731773, 1630.4049022106933, 1688.6116193275545, 1715.476779582227, 1743.9247295718094, 6593.604383736979, 7303.123625164981, 7387.889181662279, 7393.852122957537, 7397.075365579302, 7212.639368031603, 7299.963500182492, 7331.816704582388, 7333.083364579427, 7362.042934418518, 1822.6445843060608, 1830.8077651846563, 2011.5474018345901, 2073.419442556079, 2098.842586805988, 2084.3121769815925, 2092.9581408371823, 2099.2862426774896, 2100.59038487495, 2115.9788402115937, 2021.5451523407262, 2042.1831267493048, 2067.5554755727517, 2080.573482436097, 2089.5716378142442, 1999.6700544410155, 2032.034783477851, 2064.4941989212666, 2092.142221689108, 2098.8635738677012, 2096.507320779631, 2118.120979793384, 2119.98940005299, 2120.703101565782, 2122.352682431858, 7316.0, 7335.816604584875, 7354.926450735531, 7358.889616655754, 7422.146453157902, 4452.844150454718, 4479.59683628475, 4480.103979204172, 4482.753448560328, 4568.817247310104, 2389.784919357249, 2585.8448493090286, 2733.630959820419, 2737.438825040862, 2768.211059847954, 765.1850778920488, 800.7637746864631, 831.1729828820362, 835.2941764209294, 851.4763420496412, 9782.902170978341, 9875.703728888146, 9889.75275618108, 9894.158996485306, 9932.90067099327, 3950.051987523031, 4011.29802284599, 4029.697772667003, 4061.7156799023783, 4064.04494943688, 8349.582520873932, 8359.498430094214, 8360.0, 8378.413511054168, 8381.161883811692, 4489.461264648263, 4492.0791237796175, 4500.099980003947, 4500.482444518857, 4517.5482451755215, 4105.58944105587, 4114.547399786021, 4116.217918595517, 4142.46148000758, 4144.067584793397, 3501.299740052, 3502.9824850876093, 3541.026217790128, 3544.149404142987, 3551.982240088783, 1109.9944500277447, 1117.664700589836, 1120.506976930148, 1130.9943450282697, 1136.2330426961769, 717.5694583250008, 733.4096052677539, 739.4306384084225, 742.4320394897908, 743.1490942870491, 6530.967345163243, 6574.145361103122, 6574.408303252634, 6582.539222254492, 6680.565763225375, 406.5467004290254, 411.9485064366954, 416.57509340472546, 417.54696154671916, 431.78626579843177, 4777.689450185727, 4847.684900481458, 4927.531884471041, 4940.407151141886, 4956.157453232959, 8374.790630234293, 8517.787055323666, 8597.828043439096, 8661.566921653892, 8663.393562450568, 8559.0, 8563.272121869586, 8563.743087707378, 8568.22885940256, 8581.442206256574, 6786.253512113663, 6859.039734437183, 6859.142607174103, 6890.10428644273, 6910.412614927687, 6931.514793964374, 6938.791836244921, 6947.861042779015, 6966.303369662993, 6976.860462790817, 7728.45900786962, 7865.410094243069, 7885.526868387915, 7942.046954365514, 8012.919870801217, 7874.527528348317, 8004.759857204293, 8141.307988821017, 8143.42995990275, 8147.429679922348, 6512.804615861532, 6523.478121750343, 6591.143151390289, 6595.406413422623, 6618.536702430783, 6457.773977910751, 6552.3447655236005, 6562.77030303937, 6588.571742836701, 6621.966890165519, 6573.211214654272, 6620.8344791380605, 6638.468922486286, 6723.428508576826, 6792.21889482696, 6421.229452465547, 6495.870082598416, 6500.0, 6585.143931289093, 6608.537402381787, 6094.238220222473, 6128.571000030133, 6142.416470435302, 6149.84625384369, 6161.537884658758, 5639.210510528611, 5702.914456283076, 5716.228309178207, 5738.454846789548, 5743.62666426681, 4872.975635121802, 5625.690587017753, 5658.122990936411, 5659.9151012735665, 5712.571557133148], "ext.html": [526.6787259771538, 527.5621234375469, 533.9946600533993, 544.6106034185558, 559.5160186438732, 29997.250068748293, 31407.0, 36881.44677829835, 37469.437958430644, 37943.0, 41322.7933860331, 41547.376789348185, 41992.79003604985, 42053.0, 42097.368539471936, 8075.152109028556, 8509.446885952393, 8703.260222881063, 8793.208611224989, 8796.47221166732, 8035.075966263867, 10301.330413523097, 10499.265051446402, 10656.520456579434, 10697.0, 10241.28311018229, 10373.429461379621, 10411.791764164713, 10534.209934254923, 10536.947315263451, 8203.794905127419, 8327.625256863455, 10262.38425694457, 10284.228682848816, 10312.89687103127, 10162.237832162617, 10190.286679932407, 10236.94881525595, 10244.436555989418, 10320.896791032068, 37684.43473347902, 38149.0, 38202.42696359557, 38255.61744382548, 38596.421053684215, 2874.8275103493856, 2889.3426373800517, 2894.9855250723613, 3407.944248099925, 3410.2326976430354, 25961.870190649115, 25965.0, 26725.331866703295, 26932.461350772875, 27114.322141946413, 2136.0, 2147.226998280618, 2205.2612374854443, 2237.574860776447, 2293.7820907013806, 269335.0, 270908.0, 271026.999999998, 271485.0, 271952.0, 55234.723826380614, 56424.71787641035, 63502.36497634964, 64625.67687161534, 65512.344876550625, 59221.40778592245, 59769.0, 59913.101303480486, 60532.394676052674, 60542.39457605367, 15762.684746305238, 16068.276927538289, 16088.75866861998, 16099.597510062107, 16130.677386452206, 11970.82043769344, 12191.87808121925, 12231.510739570496, 12369.443375048144, 12429.689257768447, 19071.637244375805, 19385.806141938683, 19481.12334944931, 19495.90252048759, 19578.31475898365, 7682.308592226726, 7888.447808653454, 7892.802679933047, 7894.723684671009, 7970.681172753141, 820.4953953318666, 937.854632531945, 992.151710287708, 1037.4127584795276, 1088.1403691084113, 27814.86092569524, 27824.721752782618, 27929.860350698116, 28118.718812812018, 30151.396972060436, 923.1599244687302, 1026.779242462874, 1045.7856139491387, 1104.2380757277454, 1136.1138312116561, 13970.161790292615, 14176.574702758933, 14403.0, 14514.346854391577, 14523.128612283297, 321738.0, 321886.0, 322080.0, 322092.0, 326260.0, 45286.09427811425, 46122.76938615285, 46285.305720414224, 52436.21345679818, 52779.47220527822, 1313.934303284832, 1338.8928885689122, 1350.9324533773272, 1361.720847226336, 1363.270650202157, 25476.49047019012, 25618.487630247662, 26138.215853524423, 28018.579721304606, 28803.711962880105, 44183.33724994063, 45451.77274113608, 45588.54411455843, 51355.0, 52221.0, 197948.0, 199451.0, 204690.0, 206819.0, 207123.0, 29072.709272907847, 29396.118116456542, 30186.094417167522, 30483.542746859257, 30496.847515762278, 37505.62494375021, 39966.40050399304, 40036.59963400445, 42026.159476810906, 42103.57896420996, 33308.0, 33799.83100084484, 35086.12284692903, 35187.47218791669, 35479.11302217465, 31430.528542071428, 31594.36811263716, 32033.199170020936, 32060.5190922141, 32227.033189004367, 31980.68019319777, 32214.516782247818, 32731.672683272864, 32852.0, 33043.504347434326, 28132.71867281383, 30099.247518812204, 30222.395552088394, 30279.545806813356, 30561.388772224876, 22897.88551057234, 23040.308790736304, 23062.0, 23157.88421057884, 23219.419514511595], "prototype.html": [274.1241732664138, 283.34971241001904, 298.9715976982187, 313.3154058382436, 314.32577122073167, 5554.444555544444, 5569.331680198372, 5594.188842617818, 5634.098544232924, 5683.147527870821, 5346.385165705945, 5467.589930755189, 5476.4249753775775, 5574.10814269717, 5575.080111781562, 4365.825366985317, 4403.7798110094445, 4424.40270563473, 4434.224010798113, 4457.130859482402, 4259.2546304396765, 4433.401490798749, 4436.179306828231, 4459.665525085616, 4475.28395456727, 4313.633341166004, 4333.2200203963275, 4390.385346051556, 4420.1159768046355, 4451.310046942729, 4328.350747387885, 4397.31841564558, 4405.0969551241915, 4417.359482874966, 4427.092446048552, 3822.4648549203134, 3824.235152969389, 3829.7319187656876, 3832.9616703832885, 3839.731218814684, 5325.680459172462, 5412.9458705412835, 5430.83707488776, 5448.019356515825, 5452.991196628596, 4657.743824089674, 4708.764561771898, 4717.834875779331, 4738.2892566115015, 4750.382450281441, 5824.271966004249, 5839.0, 5846.473817356416, 5854.238948936653, 5893.852653683649, 3854.614538546151, 3861.2663593917064, 3864.632859878307, 3865.3042452358563, 3875.0, 6061.757529698851, 6069.453749162552, 6130.111133885562, 6134.0, 6219.626822390671, 4023.0, 4055.0, 4066.024154203029, 4075.572064933199, 4098.016476045787, 4123.793810309532, 4126.8238552012535, 4150.439690641725, 4153.314703074019, 4159.812808423628, 4790.473047964721, 4793.209120495149, 4803.543663351976, 4807.759612019385, 4826.396700412449, 5778.595498315161, 5863.970680146572, 5873.735681894325, 5931.762729490858, 5955.315138759098, 1459.569427019032, 1501.481988713892, 1502.0386952350505, 1505.0819000409742, 1505.954821355361, 953.2659851913987, 958.2669258017622, 972.0571046085286, 981.6711401680517, 984.5372674842812, 5692.829215123553, 5716.714164291769, 5721.885562288731, 5770.653760774367, 5783.190353350535, 6155.322914479404, 6162.7226774795245, 6165.815025549241, 6205.0, 6236.812895613139, 5511.889762204813, 5575.860603484945, 5604.85987850307, 5675.0, 5716.142578613241, 3354.194993201663, 3367.747418943589, 3381.239221175216, 3394.1514621344663, 3398.218409765768, 6119.388061193845, 6137.294211165773, 6144.8771024579255, 6159.722812473449, 6168.475679567197, 6012.909806352908, 6231.660193058514, 6251.156093927352, 6268.49852011838, 6288.465480434214, 6195.628262304276, 6206.751729930752, 6210.658413787375, 6226.40849119333, 6309.242890853127, 6163.35284795108, 6184.412480814495, 6206.162168107428, 6257.906131407942, 6266.843328916813, 5876.764929402776, 6100.2984656763265, 6108.992016317436, 6135.84660383494, 6157.415045570664, 6188.350223226496, 6204.441600255998, 6231.906521402273, 6271.247450305992, 6287.874242515216, 3980.144268982183, 3983.382575700771, 3988.1824226033013, 3991.8203680833853, 3996.300647386754, 5991.940080599138, 6166.1983942087245, 6171.6297022178815, 6183.196184495987, 6209.906851397142, 5921.3782552831335, 6019.006863867413, 6025.216721826135, 6032.185654936703, 6050.092486127116, 5974.2830860297045, 5981.461668449686, 5994.490468310242, 6002.789902353396, 6006.699665016644, 5837.0, 5861.472467477777, 5861.6189947653265, 5881.059030555261, 5881.588288819741, 5837.591368604157, 5933.940660593512, 5937.524998000236, 5940.079287710412, 5962.791302304398, 5789.478946894799, 5811.389804070512, 5817.709114544171, 5844.415558444121, 5851.034579294369], "yui.html": [627.0969803482988, 653.9699972543245, 673.1551902362536, 695.9977632209618, 736.6390468670353, 12879.356032198388, 13083.411246493906, 13265.27041012744, 13293.335333233348, 13297.800532992002, 12137.939310303436, 12245.265284082961, 12246.387680615955, 12294.446749896253, 12310.015198784098, 668.8996650502415, 684.7637565040053, 844.4553263145268, 868.0494858130337, 869.2654706772767, 853.1255463150289, 857.5712143928037, 868.8531138896659, 869.3697069624503, 869.9217070463657, 895.5701263393543, 898.7258886039755, 902.4855832175663, 903.7062954539768, 905.8369493491169, 724.7499612633633, 728.8396552758385, 881.5900606218139, 898.7618281155499, 899.4468401932797, 665.0722242471774, 665.2216906219735, 666.040901102411, 666.1573110015834, 666.2338310942455, 12984.350782460933, 13187.802182967167, 13256.867431325756, 13290.800637990438, 13307.268100254481, 11066.778664426747, 11091.33451992883, 11158.944205279004, 11227.494762735696, 11420.88579114215, 8695.347848911357, 8781.956090219572, 9152.17630413266, 9186.356955013152, 9211.585478653476, 3091.2426455518316, 3122.9063128106195, 3160.8261545614982, 3175.3173067790535, 3221.1463962049843, 47009.0, 47060.05879882383, 47080.29379559309, 47115.52884471146, 47840.0, 8205.179482051746, 8233.259006689306, 8246.257836794717, 8269.21442462965, 8652.78368040804, 17807.287708491516, 17946.461606151835, 18029.909850450666, 18044.458666240032, 18251.361202357853, 6507.511936604679, 6681.498887583451, 6682.732690692415, 6783.694733736895, 6961.40828029613, 3376.611689655721, 3598.1544337080763, 3610.9277814443562, 3611.602723700391, 3681.6134305897494, 2715.5383584790634, 2749.0, 2754.4353407551403, 2758.1863350311705, 2761.5995680626597, 368.85614610302, 388.0879932159403, 391.16291136966913, 391.25856501928683, 396.5875489490897, 480.3597250559647, 480.5218807286772, 508.16914345045376, 520.476920694707, 525.225292693282, 6496.415322620986, 6666.400023997767, 6667.695324749027, 6695.665216739144, 6741.460683145337, 460.27047130298183, 490.4090570862103, 497.6889444097439, 509.21072337876143, 533.5704757670035, 3237.7813951641383, 3239.72462340699, 3337.2324365396094, 3369.629340772513, 3630.5824830144343, 53484.46515534873, 53812.46187538153, 54479.0, 54481.727591362585, 55043.44956550383, 50345.24482132771, 50850.49149508458, 50921.0, 50982.74508627507, 51019.744901275255, 44493.777531112784, 44714.77642611701, 46029.07941841144, 46988.29517557239, 47352.28971565429, 7549.2073332299315, 7602.657880395506, 7718.459707820399, 7802.72690455854, 7898.0, 33100.1724956878, 33566.66433335733, 33682.66317336795, 33710.0, 33719.15702107467, 43831.561684382745, 46292.53707463017, 46718.53281467142, 46718.53281467278, 47835.521644783104, 7054.224035356004, 7471.551706897603, 7508.249175082667, 7527.887081693889, 7653.119891212582, 10318.329308594917, 10406.115480183966, 10807.891921080689, 10815.567377305135, 11565.132615054074, 9684.51577421112, 9718.173955213886, 9840.557174927002, 9853.753656158367, 9880.654177103766, 10071.798564028531, 10088.092071713581, 10112.696619101438, 10118.0, 10186.286959912735, 9546.284028697737, 9640.90359096428, 9681.70954871355, 9697.0, 9809.509524523888, 8748.69379571712, 8930.86603700958, 8986.730398088068, 8997.37018408705, 9158.816823663623, 7400.5189662671755, 8288.58557072156, 8417.158284171534, 8449.45078569891, 8465.238128568211]}, "summary": {"suite": 6429.121942787094, "subtests": {"jquery.html": {"filtered": 7884.411948298894, "value": 7884.411948298894}, "dojo.html": {"filtered": 5009.23801982077, "value": 5009.23801982077}, "mootools.html": {"filtered": 3990.02429819396, "value": 3990.02429819396}, "ext.html": {"filtered": 17759.564859253063, "value": 17759.564859253063}, "prototype.html": {"filtered": 4448.21598349046, "value": 4448.21598349046}, "yui.html": {"filtered": 5671.935883410982, "value": 5671.935883410982}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0030"}, "testrun": {"date": 1448436616, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124224435", "branch": "Mozilla-Aurora", "revision": "30cb3701070945e6701d504883fe2c674eb5196e"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 179.0, 180.0, 179.0, 174.0, 172.0, 177.0, 180.0, 179.0, 176.0], "ai-astar": [109.0, 106.0, 108.0, 107.0, 117.0, 114.0, 119.0, 119.0, 112.0, 109.0], "imaging-gaussian-blur": [136.0, 130.0, 135.0, 130.0, 135.0, 125.0, 136.0, 136.0, 135.0, 135.0], "audio-beat-detection": [165.0, 143.0, 177.0, 168.0, 140.0, 161.0, 139.0, 175.0, 165.0, 138.0], "json-stringify-tinderbox": [67.0, 70.0, 71.0, 74.0, 76.0, 76.0, 75.0, 84.0, 76.0, 75.0], "stanford-crypto-pbkdf2": [152.0, 162.0, 160.0, 164.0, 160.0, 160.0, 160.0, 159.0, 159.0, 156.0], "json-parse-financial": [57.0, 64.0, 67.0, 68.0, 70.0, 70.0, 70.0, 79.0, 65.0, 64.0], "stanford-crypto-sha256-iterative": [68.0, 72.0, 74.0, 78.0, 78.0, 78.0, 77.0, 78.0, 77.0, 78.0], "audio-fft": [81.0, 88.0, 87.0, 131.0, 73.0, 78.0, 79.0, 79.0, 135.0, 73.0], "imaging-darkroom": [135.0, 140.0, 140.0, 140.0, 140.0, 141.0, 140.0, 140.0, 140.0, 134.0], "stanford-crypto-ccm": [130.0, 134.0, 140.0, 138.0, 140.0, 135.0, 140.0, 141.0, 148.0, 137.0], "audio-oscillator": [104.0, 106.0, 153.0, 98.0, 101.0, 100.0, 142.0, 97.0, 98.0, 146.0], "stanford-crypto-aes": [86.0, 89.0, 91.0, 93.0, 95.0, 97.0, 93.0, 91.0, 91.0, 96.0], "imaging-desaturate": [112.0, 113.0, 113.0, 114.0, 114.0, 116.0, 116.0, 112.0, 114.0, 112.0]}, "summary": {"suite": 1644.0000000000002, "subtests": {"audio-fft": {"filtered": 90.4, "value": 90.4}, "stanford-crypto-pbkdf2": {"filtered": 159.2, "value": 159.2}, "audio-beat-detection": {"filtered": 157.1, "value": 157.1}, "stanford-crypto-ccm": {"filtered": 138.3, "value": 138.3}, "imaging-darkroom": {"filtered": 139.0, "value": 139.0}, "json-parse-financial": {"filtered": 67.4, "value": 67.4}, "audio-oscillator": {"filtered": 114.5, "value": 114.5}, "ai-astar": {"filtered": 112.0, "value": 112.0}, "audio-dft": {"filtered": 176.8, "value": 176.8}, "stanford-crypto-sha256-iterative": {"filtered": 75.8, "value": 75.8}, "json-stringify-tinderbox": {"filtered": 74.4, "value": 74.4}, "imaging-gaussian-blur": {"filtered": 133.3, "value": 133.3}, "stanford-crypto-aes": {"filtered": 92.2, "value": 92.2}, "imaging-desaturate": {"filtered": 113.6, "value": 113.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0030"}, "testrun": {"date": 1448436616, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124224435", "branch": "Mozilla-Aurora", "revision": "30cb3701070945e6701d504883fe2c674eb5196e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [204.08163265306123], "Encrypt": [354.86160397444996], "NavierStokes": [6308.176100628931], "Decrypt": [6320.754716981132], "Splay": [720.9805335255949], "Richards": [176.0253476500616], "RegExp": [32000.0], "Earley": [753.5795026375282], "Boyer": [13863.013698630137], "RayTrace": [1121.0762331838564]}, "summary": {"suite": 18454.61240309763, "subtests": {"DeltaBlue": {"filtered": 323.97820000000013, "value": 323.97820000000013}, "Encrypt": {"filtered": 750.098058, "value": 750.098058}, "NavierStokes": {"filtered": 235.25024925224326, "value": 235.25024925224326}, "Decrypt": {"filtered": 42.11221791044778, "value": 42.11221791044778}, "Splay": {"filtered": 113.028017, "value": 113.028017}, "RegExp": {"filtered": 28.468281250000008, "value": 28.468281250000008}, "Richards": {"filtered": 200.55066200000005, "value": 200.55066200000005}, "Earley": {"filtered": 884.3964010000001, "value": 884.3964010000001}, "Boyer": {"filtered": 48.07490019762843, "value": 48.07490019762843}, "RayTrace": {"filtered": 660.070188, "value": 660.070188}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0030"}, "testrun": {"date": 1448436616, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151124224435", "branch": "Mozilla-Aurora", "revision": "30cb3701070945e6701d504883fe2c674eb5196e"}}] 23:50:28 INFO - RETURN: dromaeo_css: 6429.12 23:50:28 INFO - RETURN: kraken: 1644.00 23:50:28 INFO - RETURN: v8_7: 18454.61 23:50:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18454.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1644.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6429.12"}}} 23:50:28 INFO - Return code: 0 23:50:28 INFO - # TBPL SUCCESS # 23:50:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:50:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:50:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:50:28 INFO - 2015-11-24 23:50:28.836 screenresolution[1659:10280] starting screenresolution argv=screenresolution get 23:50:28 INFO - 2015-11-24 23:50:28.840 screenresolution[1659:10280] Display 0: 1600x1200x32@60 23:50:28 INFO - 2015-11-24 23:50:28.846 screenresolution[1660:10283] starting screenresolution argv=screenresolution list 23:50:28 INFO - Available Modes on Display 0 23:50:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:50:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:50:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:50:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:50:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:50:29 INFO - Intel HD Graphics 3000: 23:50:29 INFO - Chipset Model: Intel HD Graphics 3000 23:50:29 INFO - Type: GPU 23:50:29 INFO - Bus: Built-In 23:50:29 INFO - VRAM (Total): 512 MB 23:50:29 INFO - VRAM (Dynamic, Max): 10 23:50:29 INFO - Vendor: Intel (0x8086) 23:50:29 INFO - Device ID: 0x0116 23:50:29 INFO - Revision ID: 0x0009 23:50:29 INFO - Displays: 23:50:29 INFO - Display: 23:50:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:50:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:50:29 INFO - Display Serial Number: 1600x1200 60 23:50:29 INFO - Main Display: Yes 23:50:29 INFO - Mirror: Off 23:50:29 INFO - Online: Yes 23:50:29 INFO - Rotation: Supported 23:50:29 INFO - Return code: 0 23:50:29 INFO - Running post-action listener: _resource_record_post_action 23:50:29 INFO - Running post-run listener: _resource_record_post_run 23:50:30 INFO - Total resource usage - Wall time: 1252s; CPU: 30.0%; Read bytes: 39175168; Write bytes: 687717376; Read time: 4503; Write time: 32037 23:50:30 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 336663040; Write bytes: 335826944; Read time: 33819; Write time: 7912 23:50:30 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 37188608; Write bytes: 340794368; Read time: 4064; Write time: 22609 23:50:30 INFO - Running post-run listener: _upload_blobber_files 23:50:30 INFO - Blob upload gear active. 23:50:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:50:30 INFO - Copying logs to upload dir... 23:50:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.429004 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2015-11-24 23:50:30.247560) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 23:50:30.252710) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009996 build_url: 'https://queue.taskcluster.net/v1/task/FFV122wfRNWvm9wQ6lsoFA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 23:50:30.273236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:50:30.273555) ========= 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.AFHUeEoMJT/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.QgZ5SghWNP/Listeners TMPDIR=/var/folders/cr/2m0837vd7sg2m4jyqg4dr20000000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005416 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 23:50:30.322138) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 23:50:30.322451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 23:50:30.322820) ========= ========= Total master_lag: 0.47 =========