builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0013 starttime: 1448293723.42 results: success (0) buildid: 20151123055225 builduid: 3f6d035eb9b8437bb642cc3b89bc4359 revision: dc1991dd52f13423e6b8ec6c73b9931284c253c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:43.424885) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:43.425354) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:43.425747) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.005658 basedir: '/builds/slave/test' ========= master_lag: 0.52 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:43.955765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:43.956076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.023667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.023967) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.033172 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.075461) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.075722) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.076043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.076321) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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-23 07:48:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.50M=0.001s 2015-11-23 07:48:44 (9.50 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.279774 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.367556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.367896) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.170884 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:44.548205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 07:48:44.548690) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dc1991dd52f13423e6b8ec6c73b9931284c253c8 --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 dc1991dd52f13423e6b8ec6c73b9931284c253c8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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-23 07:48:44,707 truncating revision to first 12 chars 2015-11-23 07:48:44,707 Setting DEBUG logging. 2015-11-23 07:48:44,707 attempt 1/10 2015-11-23 07:48:44,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dc1991dd52f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 07:48:46,070 unpacking tar archive at: mozilla-aurora-dc1991dd52f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.659057 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 07:48:46.249068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:46.249496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:46.264992) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:46.265390) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:48:46.265870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2015-11-23 07:48:46.266175) ========= /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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:48:46 INFO - MultiFileLogger online at 20151123 07:48:46 in /builds/slave/test 07:48:46 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 07:48:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:48:46 INFO - {'append_to_log': False, 07:48:46 INFO - 'base_work_dir': '/builds/slave/test', 07:48:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:48:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:48:46 INFO - 'branch': 'Mozilla-Aurora', 07:48:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:48:46 INFO - 'config_files': ('talos/mac_config.py',), 07:48:46 INFO - 'default_actions': ('clobber', 07:48:46 INFO - 'read-buildbot-config', 07:48:46 INFO - 'download-and-extract', 07:48:46 INFO - 'populate-webroot', 07:48:46 INFO - 'create-virtualenv', 07:48:46 INFO - 'install', 07:48:46 INFO - 'run-tests'), 07:48:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:48:46 INFO - 'download_minidump_stackwalk': True, 07:48:46 INFO - 'download_symbols': 'ondemand', 07:48:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:48:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:48:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:48:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:48:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:48:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:48:46 INFO - 'installer_path': 'installer.exe', 07:48:46 INFO - 'log_level': 'info', 07:48:46 INFO - 'log_name': 'talos', 07:48:46 INFO - 'log_to_console': True, 07:48:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:48:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:48:46 INFO - 'opt_config_files': (), 07:48:46 INFO - 'pip_index': False, 07:48:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:46 INFO - 'cmd': ('bash', 07:48:46 INFO - '-c', 07:48:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:46 INFO - 'enabled': True, 07:48:46 INFO - 'halt_on_failure': False, 07:48:46 INFO - 'name': 'check_screen_resolution'},), 07:48:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:46 INFO - 'cmd': ('bash', 07:48:46 INFO - '-c', 07:48:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:46 INFO - 'enabled': True, 07:48:46 INFO - 'halt_on_failure': False, 07:48:46 INFO - 'name': 'check_screen_resolution'},), 07:48:46 INFO - 'run_cmd_checks_enabled': True, 07:48:46 INFO - 'sps_profile': False, 07:48:46 INFO - 'sps_profile_interval': 0, 07:48:46 INFO - 'suite': 'dromaeojs', 07:48:46 INFO - 'system_bits': '64', 07:48:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:48:46 INFO - 'title': 't-yosemite-r5-0013', 07:48:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:48:46 INFO - 'use_talos_json': True, 07:48:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:48:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:48:46 INFO - 'work_dir': 'build'} 07:48:46 INFO - ##### 07:48:46 INFO - ##### Running clobber step. 07:48:46 INFO - ##### 07:48:46 INFO - Running pre-action listener: _resource_record_pre_action 07:48:46 INFO - Running main action method: clobber 07:48:46 INFO - rmtree: /builds/slave/test/build 07:48:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:48:50 INFO - Running post-action listener: _resource_record_post_action 07:48:50 INFO - ##### 07:48:50 INFO - ##### Running read-buildbot-config step. 07:48:50 INFO - ##### 07:48:50 INFO - Running pre-action listener: _resource_record_pre_action 07:48:50 INFO - Running main action method: read_buildbot_config 07:48:50 INFO - Using buildbot properties: 07:48:50 INFO - { 07:48:50 INFO - "properties": { 07:48:50 INFO - "buildnumber": 435, 07:48:50 INFO - "product": "firefox", 07:48:50 INFO - "script_repo_revision": "production", 07:48:50 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 07:48:50 INFO - "repository": "", 07:48:50 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 07:48:50 INFO - "buildid": "20151123055225", 07:48:50 INFO - "slavename": "t-yosemite-r5-0013", 07:48:50 INFO - "pgo_build": "False", 07:48:50 INFO - "basedir": "/builds/slave/test", 07:48:50 INFO - "project": "", 07:48:50 INFO - "platform": "yosemite", 07:48:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:48:50 INFO - "slavebuilddir": "test", 07:48:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:48:50 INFO - "branch": "mozilla-aurora", 07:48:50 INFO - "repo_path": "releases/mozilla-aurora", 07:48:50 INFO - "stage_platform": "macosx64", 07:48:50 INFO - "builduid": "3f6d035eb9b8437bb642cc3b89bc4359", 07:48:50 INFO - "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8" 07:48:50 INFO - }, 07:48:50 INFO - "sourcestamp": { 07:48:50 INFO - "repository": "", 07:48:50 INFO - "hasPatch": false, 07:48:50 INFO - "project": "", 07:48:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 07:48:50 INFO - "changes": [ 07:48:50 INFO - { 07:48:50 INFO - "category": null, 07:48:50 INFO - "files": [ 07:48:50 INFO - { 07:48:50 INFO - "url": null, 07:48:50 INFO - "name": "https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 07:48:50 INFO - } 07:48:50 INFO - ], 07:48:50 INFO - "repository": "", 07:48:50 INFO - "rev": "dc1991dd52f13423e6b8ec6c73b9931284c253c8", 07:48:50 INFO - "who": "cbook@mozilla.com", 07:48:50 INFO - "when": 1448293709, 07:48:50 INFO - "number": 6695336, 07:48:50 INFO - "comments": "Bug 1225970 - dispatch an event to release the widget after draw. r=roc, a=lizzard", 07:48:50 INFO - "project": "", 07:48:50 INFO - "at": "Mon 23 Nov 2015 07:48:29", 07:48:50 INFO - "branch": "mozilla-aurora-macosx64-talos", 07:48:50 INFO - "revlink": "", 07:48:50 INFO - "properties": [ 07:48:50 INFO - [ 07:48:50 INFO - "buildid", 07:48:50 INFO - "20151123055225", 07:48:50 INFO - "Change" 07:48:50 INFO - ], 07:48:50 INFO - [ 07:48:50 INFO - "builduid", 07:48:50 INFO - "3f6d035eb9b8437bb642cc3b89bc4359", 07:48:50 INFO - "Change" 07:48:50 INFO - ], 07:48:50 INFO - [ 07:48:50 INFO - "pgo_build", 07:48:50 INFO - "False", 07:48:50 INFO - "Change" 07:48:50 INFO - ] 07:48:50 INFO - ], 07:48:50 INFO - "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8" 07:48:50 INFO - } 07:48:50 INFO - ], 07:48:50 INFO - "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8" 07:48:50 INFO - } 07:48:50 INFO - } 07:48:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 07:48:50 INFO - Running post-action listener: _resource_record_post_action 07:48:50 INFO - ##### 07:48:50 INFO - ##### Running download-and-extract step. 07:48:50 INFO - ##### 07:48:50 INFO - Running pre-action listener: _resource_record_pre_action 07:48:50 INFO - Running main action method: download_and_extract 07:48:50 INFO - mkdir: /builds/slave/test/build/tests 07:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:50 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json 07:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json 07:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:49:20 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json: timed out 07:49:20 INFO - retry: attempt #1 caught exception: timed out 07:49:20 INFO - retry: Failed, sleeping 30 seconds before retrying 07:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 07:49:51 INFO - Downloaded 1149 bytes. 07:49:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:49:51 INFO - Using the following test package requirements: 07:49:51 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 07:49:51 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 07:49:51 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'jsshell-mac.zip'], 07:49:51 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 07:49:51 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 07:49:51 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 07:49:51 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 07:49:51 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 07:49:51 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 07:49:51 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 07:49:51 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 07:49:51 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:51 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:49:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:49:53 INFO - Downloaded 17448015 bytes. 07:49:53 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 07:49:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 07:49:58 INFO - Return code: 0 07:49:58 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 07:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:58 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:49:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:49:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:49:59 INFO - Downloaded 17448015 bytes. 07:49:59 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 07:49:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 07:49:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 07:50:04 INFO - Return code: 0 07:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:04 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:50:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 07:50:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 07:50:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:50:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:50:05 INFO - Downloaded 11131307 bytes. 07:50:05 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 07:50:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 07:50:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 07:50:06 INFO - Return code: 0 07:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:06 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 07:50:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 07:50:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 07:50:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 07:50:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:50:09 INFO - Downloaded 107801002 bytes. 07:50:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 07:50:09 INFO - mkdir: /builds/slave/test/properties 07:50:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:09 INFO - Contents: 07:50:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 07:50:09 INFO - Running post-action listener: _resource_record_post_action 07:50:09 INFO - Running post-action listener: set_extra_try_arguments 07:50:09 INFO - ##### 07:50:09 INFO - ##### Running populate-webroot step. 07:50:09 INFO - ##### 07:50:09 INFO - Running pre-action listener: _resource_record_pre_action 07:50:09 INFO - Running main action method: populate_webroot 07:50:09 INFO - Guessing talos json url... 07:50:09 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')]} 07:50:09 INFO - https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 07:50:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 07:50:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 07:50:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 07:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/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 07:50:09 INFO - Downloaded 107 bytes. 07:50:09 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 07:50:09 INFO - Contents: 07:50:09 INFO - 20151123055225 07:50:09 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/dc1991dd52f13423e6b8ec6c73b9931284c253c8 07:50:09 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')]} 07:50:09 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/dc1991dd52/testing/talos/talos.json 07:50:09 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/dc1991dd52/testing/talos/talos.json to /builds/slave/test/build/talos.json 07:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/dc1991dd52/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 07:50:10 INFO - Downloaded 4264 bytes. 07:50:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:50:10 INFO - '../fennec_ids.txt'], 07:50:10 INFO - 'tests': ['tcheck2']}, 07:50:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:10 INFO - '--tppagecycles', 07:50:10 INFO - '7'], 07:50:10 INFO - 'tests': ['tsvgm']}}, 07:50:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:50:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:50:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:50:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'tests': ['damp', 'tps']}, 07:50:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['damp', 'tps']}, 07:50:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:50:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:10 INFO - 'other': {'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'other_l64': {'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'other_nol64': {'tests': ['a11yr', 07:50:10 INFO - 'ts_paint', 07:50:10 INFO - 'tpaint', 07:50:10 INFO - 'sessionrestore', 07:50:10 INFO - 'sessionrestore_no_auto_restore']}, 07:50:10 INFO - 'svgr': {'tests': ['tsvgx', 07:50:10 INFO - 'tsvgr_opacity', 07:50:10 INFO - 'tart', 07:50:10 INFO - 'tscrollx', 07:50:10 INFO - 'cart']}, 07:50:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['tsvgx', 07:50:10 INFO - 'tsvgr_opacity', 07:50:10 INFO - 'tart', 07:50:10 INFO - 'tscrollx', 07:50:10 INFO - 'cart']}, 07:50:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'tests': ['tp5o']}, 07:50:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'talos_options': ['--e10s'], 07:50:10 INFO - 'tests': ['tp5o']}, 07:50:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'talos_options': ['--xperf_path', 07:50:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:10 INFO - 'tests': ['tp5n']}, 07:50:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:10 INFO - 'talos_options': ['--e10s', 07:50:10 INFO - '--xperf_path', 07:50:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 07:50:10 INFO - 'C:/slave/talos-data/talos/xperf.config'], 07:50:10 INFO - 'tests': ['tp5n']}}, 07:50:10 INFO - 'talos.zip': {'path': '', 07:50:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:10 INFO - Running post-action listener: _resource_record_post_action 07:50:10 INFO - ##### 07:50:10 INFO - ##### Running create-virtualenv step. 07:50:10 INFO - ##### 07:50:10 INFO - Running pre-action listener: _resource_record_pre_action 07:50:10 INFO - Running main action method: create_virtualenv 07:50:10 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:10 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 07:50:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:10 INFO - Using real prefix '/tools/python27' 07:50:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:15 INFO - Installing pip.................done. 07:50:15 INFO - Return code: 0 07:50:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:15 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:15 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 07:50:15 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 07:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:15 INFO - 'HOME': '/Users/cltbld', 07:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:15 INFO - 'LOGNAME': 'cltbld', 07:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:15 INFO - 'MOZ_NO_REMOTE': '1', 07:50:15 INFO - 'NO_EM_RESTART': '1', 07:50:15 INFO - 'PAGER': '/bin/cat', 07:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:15 INFO - 'PWD': '/builds/slave/test', 07:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:15 INFO - 'SHELL': '/bin/bash', 07:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:15 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:15 INFO - 'USER': 'cltbld', 07:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:15 INFO - 'XPC_FLAGS': '0x0', 07:50:15 INFO - 'XPC_SERVICE_NAME': '0', 07:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:16 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 07:50:16 INFO - Cleaning up... 07:50:16 INFO - Return code: 0 07:50:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:16 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:16 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 07:50:16 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 07:50:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:16 INFO - 'HOME': '/Users/cltbld', 07:50:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:16 INFO - 'LOGNAME': 'cltbld', 07:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:16 INFO - 'MOZ_NO_REMOTE': '1', 07:50:16 INFO - 'NO_EM_RESTART': '1', 07:50:16 INFO - 'PAGER': '/bin/cat', 07:50:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:16 INFO - 'PWD': '/builds/slave/test', 07:50:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:16 INFO - 'SHELL': '/bin/bash', 07:50:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:16 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:16 INFO - 'USER': 'cltbld', 07:50:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:16 INFO - 'XPC_FLAGS': '0x0', 07:50:16 INFO - 'XPC_SERVICE_NAME': '0', 07:50:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:16 INFO - Downloading/unpacking psutil>=0.7.1 07:50:16 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 07:50:16 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 07:50:16 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 07:50:16 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 07:50:16 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 07:50:16 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 07:50:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:50:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:50:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:19 INFO - Installing collected packages: psutil 07:50:19 INFO - Running setup.py install for psutil 07:50:19 INFO - building 'psutil._psutil_osx' extension 07:50:19 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 07:50:20 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 07:50:21 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 07:50:21 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 07:50:21 INFO - building 'psutil._psutil_posix' extension 07:50:21 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 07:50:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:50:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:50:21 INFO - ^ 07:50:21 INFO - 1 warning generated. 07:50:21 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 07:50:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:21 INFO - Successfully installed psutil 07:50:21 INFO - Cleaning up... 07:50:21 INFO - Return code: 0 07:50:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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', '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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:50: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 mozsystemmonitor==0.0.0 07:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:21 INFO - 'HOME': '/Users/cltbld', 07:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:21 INFO - 'LOGNAME': 'cltbld', 07:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:21 INFO - 'MOZ_NO_REMOTE': '1', 07:50:21 INFO - 'NO_EM_RESTART': '1', 07:50:21 INFO - 'PAGER': '/bin/cat', 07:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:21 INFO - 'PWD': '/builds/slave/test', 07:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:21 INFO - 'SHELL': '/bin/bash', 07:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:21 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:21 INFO - 'USER': 'cltbld', 07:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:21 INFO - 'XPC_FLAGS': '0x0', 07:50:21 INFO - 'XPC_SERVICE_NAME': '0', 07:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:50:22 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 07:50:22 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 07:50:22 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 07:50:22 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 07:50:22 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 07:50:22 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 07:50:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:50:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:50:24 INFO - Installing collected packages: mozsystemmonitor 07:50:24 INFO - Running setup.py install for mozsystemmonitor 07:50:24 INFO - Successfully installed mozsystemmonitor 07:50:24 INFO - Cleaning up... 07:50:24 INFO - Return code: 0 07:50:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:24 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:24 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 07:50:24 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 07:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:24 INFO - 'HOME': '/Users/cltbld', 07:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:24 INFO - 'LOGNAME': 'cltbld', 07:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:24 INFO - 'MOZ_NO_REMOTE': '1', 07:50:24 INFO - 'NO_EM_RESTART': '1', 07:50:24 INFO - 'PAGER': '/bin/cat', 07:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:24 INFO - 'PWD': '/builds/slave/test', 07:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:24 INFO - 'SHELL': '/bin/bash', 07:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:24 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:24 INFO - 'USER': 'cltbld', 07:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:24 INFO - 'XPC_FLAGS': '0x0', 07:50:24 INFO - 'XPC_SERVICE_NAME': '0', 07:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:25 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:27 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 07:50:27 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 07:50:27 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 07:50:27 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 07:50:27 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 07:50:27 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 07:50:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:50:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:28 INFO - Downloading docopt-0.6.1.tar.gz 07:50:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:28 INFO - Running setup.py install for blobuploader 07:50:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:50:28 INFO - Running setup.py install for requests 07:50:29 INFO - Running setup.py install for docopt 07:50:29 INFO - Successfully installed blobuploader requests docopt 07:50:29 INFO - Cleaning up... 07:50:29 INFO - Return code: 0 07:50:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:29 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')]} 07:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:29 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')]} 07:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:29 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:29 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 07:50:29 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 07:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:29 INFO - 'HOME': '/Users/cltbld', 07:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:29 INFO - 'LOGNAME': 'cltbld', 07:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:29 INFO - 'MOZ_NO_REMOTE': '1', 07:50:29 INFO - 'NO_EM_RESTART': '1', 07:50:29 INFO - 'PAGER': '/bin/cat', 07:50:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:29 INFO - 'PWD': '/builds/slave/test', 07:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:29 INFO - 'SHELL': '/bin/bash', 07:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:29 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:29 INFO - 'USER': 'cltbld', 07:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:29 INFO - 'XPC_FLAGS': '0x0', 07:50:29 INFO - 'XPC_SERVICE_NAME': '0', 07:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-MMGqTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-di6iRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-C87d4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-zqWyal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-y4BwDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-zdHJ5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-5Zsywl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-n1owcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:30 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Ie_Ieb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-5oM_yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-iElLUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-fy7Lzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-JM7XUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-M2aJTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-BlrOau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-CDsCcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:31 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-0WSHlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:32 INFO - Running setup.py install for manifestparser 07:50:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:50:32 INFO - Running setup.py install for mozcrash 07:50:32 INFO - Running setup.py install for mozdebug 07:50:32 INFO - Running setup.py install for mozdevice 07:50:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:50:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:50:32 INFO - Running setup.py install for mozfile 07:50:32 INFO - Running setup.py install for mozhttpd 07:50:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Running setup.py install for mozinfo 07:50:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Running setup.py install for mozInstall 07:50:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Running setup.py install for mozleak 07:50:33 INFO - Running setup.py install for mozlog 07:50:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Running setup.py install for moznetwork 07:50:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:50:33 INFO - Running setup.py install for mozprocess 07:50:34 INFO - Running setup.py install for mozprofile 07:50:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:50:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:50:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:50:34 INFO - Running setup.py install for mozrunner 07:50:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:50:34 INFO - Running setup.py install for mozscreenshot 07:50:34 INFO - Running setup.py install for moztest 07:50:34 INFO - Running setup.py install for mozversion 07:50:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:50:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:35 INFO - Cleaning up... 07:50:35 INFO - Return code: 0 07:50:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:35 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')]} 07:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:35 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')]} 07:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:35 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:35 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 07:50:35 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 07:50:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:35 INFO - 'HOME': '/Users/cltbld', 07:50:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:35 INFO - 'LOGNAME': 'cltbld', 07:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:35 INFO - 'MOZ_NO_REMOTE': '1', 07:50:35 INFO - 'NO_EM_RESTART': '1', 07:50:35 INFO - 'PAGER': '/bin/cat', 07:50:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:35 INFO - 'PWD': '/builds/slave/test', 07:50:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:35 INFO - 'SHELL': '/bin/bash', 07:50:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:35 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:35 INFO - 'USER': 'cltbld', 07:50:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:35 INFO - 'XPC_FLAGS': '0x0', 07:50:35 INFO - 'XPC_SERVICE_NAME': '0', 07:50:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:35 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-qU2Ray-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:35 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)) 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:35 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-gIxDrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:35 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)) 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:35 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-0ZctnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:35 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)) 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:35 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-BE1qjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:35 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)) 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:35 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-qYxFUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:35 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)) 07:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-AQrXm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-OLm739-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-zgToUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-_hoO7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-LNxB1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-CbUSMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-imMJIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:36 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-cmdaoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:36 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)) 07:50:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:37 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-5NeM2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:37 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)) 07:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:37 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-qPWBIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:37 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)) 07:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:37 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-EsWdyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:37 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)) 07:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:37 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-B6mwuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:37 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)) 07:50:37 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)) 07:50: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:37 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)) 07:50:37 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)) 07:50:37 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)) 07:50:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:37 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 07:50:37 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 07:50:37 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 07:50:37 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 07:50:37 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 07:50:37 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 07:50:39 INFO - Downloading blessings-1.5.1.tar.gz 07:50:39 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 07:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:40 INFO - Installing collected packages: blessings 07:50:40 INFO - Running setup.py install for blessings 07:50:40 INFO - Successfully installed blessings 07:50:40 INFO - Cleaning up... 07:50:40 INFO - Return code: 0 07:50:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:40 INFO - Reading from file tmpfile_stdout 07:50:40 INFO - Current package versions: 07:50:40 INFO - blessings == 1.5.1 07:50:40 INFO - blobuploader == 1.2.4 07:50:40 INFO - docopt == 0.6.1 07:50:40 INFO - manifestparser == 1.1 07:50:40 INFO - mozInstall == 1.12 07:50:40 INFO - mozcrash == 0.16 07:50:40 INFO - mozdebug == 0.1 07:50:40 INFO - mozdevice == 0.46 07:50:40 INFO - mozfile == 1.2 07:50:40 INFO - mozhttpd == 0.7 07:50:40 INFO - mozinfo == 0.8 07:50:40 INFO - mozleak == 0.1 07:50:40 INFO - mozlog == 3.0 07:50:40 INFO - moznetwork == 0.27 07:50:40 INFO - mozprocess == 0.22 07:50:40 INFO - mozprofile == 0.27 07:50:40 INFO - mozrunner == 6.11 07:50:40 INFO - mozscreenshot == 0.1 07:50:40 INFO - mozsystemmonitor == 0.0 07:50:40 INFO - moztest == 0.7 07:50:40 INFO - mozversion == 1.4 07:50:40 INFO - psutil == 3.1.1 07:50:40 INFO - requests == 1.2.3 07:50:40 INFO - wsgiref == 0.1.2 07:50:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50: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')]} 07:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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')]} 07:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:40 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 0x101f4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb8228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3f2e19020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, '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.qVYMLZk88i/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.DKPxF37mOC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 07:50:40 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 07:50:40 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 07:50:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:50:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:40 INFO - 'HOME': '/Users/cltbld', 07:50:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:40 INFO - 'LOGNAME': 'cltbld', 07:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:40 INFO - 'MOZ_NO_REMOTE': '1', 07:50:40 INFO - 'NO_EM_RESTART': '1', 07:50:40 INFO - 'PAGER': '/bin/cat', 07:50:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:40 INFO - 'PWD': '/builds/slave/test', 07:50:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:40 INFO - 'SHELL': '/bin/bash', 07:50:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:50:40 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:50:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:40 INFO - 'USER': 'cltbld', 07:50:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:40 INFO - 'XPC_FLAGS': '0x0', 07:50:40 INFO - 'XPC_SERVICE_NAME': '0', 07:50:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 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)) 07:50:40 INFO - Cleaning up... 07:50:41 INFO - Return code: 0 07:50:41 INFO - Running post-action listener: _resource_record_post_action 07:50:41 INFO - Running post-action listener: _start_resource_monitoring 07:50:41 INFO - Starting resource monitoring. 07:50:41 INFO - ##### 07:50:41 INFO - ##### Running install step. 07:50:41 INFO - ##### 07:50:41 INFO - Running pre-action listener: _resource_record_pre_action 07:50:41 INFO - Running main action method: install 07:50:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:41 INFO - Reading from file tmpfile_stdout 07:50:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:50:41 INFO - Reading from file tmpfile_stdout 07:50:41 INFO - Output received: 07:50:41 INFO - Usage: mozinstall [options] installer 07:50:41 INFO - Options: 07:50:41 INFO - -h, --help show this help message and exit 07:50:41 INFO - -d DEST, --destination=DEST 07:50:41 INFO - Directory to install application into. [default: 07:50:41 INFO - "/builds/slave/test"] 07:50:41 INFO - --app=APP Application being installed. [default: firefox] 07:50:41 INFO - mkdir: /builds/slave/test/build/application 07:50:41 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'] 07:50:41 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 07:51:20 INFO - Reading from file tmpfile_stdout 07:51:20 INFO - Output received: 07:51:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:51:20 INFO - Running post-action listener: _resource_record_post_action 07:51:20 INFO - ##### 07:51:20 INFO - ##### Running run-tests step. 07:51:20 INFO - ##### 07:51:20 INFO - Running pre-action listener: _resource_record_pre_action 07:51:20 INFO - Running main action method: run_tests 07:51:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:51:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:51:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:51:20 INFO - 2015-11-23 07:51:20.162 screenresolution[1637:8182] starting screenresolution argv=screenresolution get 07:51:20 INFO - 2015-11-23 07:51:20.166 screenresolution[1637:8182] Display 0: 1600x1200x32@60 07:51:20 INFO - 2015-11-23 07:51:20.173 screenresolution[1638:8184] starting screenresolution argv=screenresolution list 07:51:20 INFO - Available Modes on Display 0 07:51:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:51:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:51:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:51:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:51:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:51:20 INFO - Intel HD Graphics 3000: 07:51:20 INFO - Chipset Model: Intel HD Graphics 3000 07:51:20 INFO - Type: GPU 07:51:20 INFO - Bus: Built-In 07:51:20 INFO - VRAM (Total): 512 MB 07:51:20 INFO - VRAM (Dynamic, Max): 10 07:51:20 INFO - Vendor: Intel (0x8086) 07:51:20 INFO - Device ID: 0x0116 07:51:20 INFO - Revision ID: 0x0009 07:51:20 INFO - Displays: 07:51:20 INFO - Display: 07:51:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:51:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:51:20 INFO - Display Serial Number: 1600x1200 60 07:51:20 INFO - Main Display: Yes 07:51:20 INFO - Mirror: Off 07:51:20 INFO - Online: Yes 07:51:20 INFO - Rotation: Supported 07:51:20 INFO - Return code: 0 07:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:51:20 INFO - Python 2.7.3 07:51:20 INFO - Return code: 0 07:51:20 INFO - grabbing minidump binary from tooltool 07:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:20 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 0x101f009f0>, '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 0x101c5fcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101eca990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:51:20 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 07:51:20 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 07:51:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:51:20 INFO - Return code: 0 07:51:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:51:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:51:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:51:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:51:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:51:20 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/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] in /builds/slave/test/build 07:51:20 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/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0013 --webServer localhost 07:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qVYMLZk88i/Render', 07:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:51:20 INFO - 'HOME': '/Users/cltbld', 07:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:51:20 INFO - 'LOGNAME': 'cltbld', 07:51:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:51:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:20 INFO - 'MOZ_NO_REMOTE': '1', 07:51:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:51:20 INFO - 'NO_EM_RESTART': '1', 07:51:20 INFO - 'PAGER': '/bin/cat', 07:51:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:20 INFO - 'PWD': '/builds/slave/test', 07:51:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:51:20 INFO - 'SHELL': '/bin/bash', 07:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DKPxF37mOC/Listeners', 07:51:20 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 07:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:51:20 INFO - 'USER': 'cltbld', 07:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:20 INFO - 'XPC_FLAGS': '0x0', 07:51:20 INFO - 'XPC_SERVICE_NAME': '0', 07:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 07:51:20 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/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] with output_timeout 3600 07:51:20 INFO - mozversion INFO | application_buildid: 20151123055225 07:51:20 INFO - mozversion INFO | application_changeset: dc1991dd52f13423e6b8ec6c73b9931284c253c8 07:51:20 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 07:51:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:51:20 INFO - mozversion INFO | application_name: Firefox 07:51:20 INFO - mozversion INFO | application_remotingname: firefox-dev 07:51:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:51:20 INFO - mozversion INFO | application_vendor: Mozilla 07:51:20 INFO - mozversion INFO | application_version: 44.0a2 07:51:20 INFO - mozversion INFO | platform_buildid: 20151123055225 07:51:20 INFO - mozversion INFO | platform_changeset: dc1991dd52f13423e6b8ec6c73b9931284c253c8 07:51:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:51:20 INFO - mozversion INFO | platform_version: 44.0a2 07:51:20 INFO - 2015-11-23 07:51:20,918 DEBUG : using testdate: 1448293880 07:51:20 INFO - 2015-11-23 07:51:20,918 DEBUG : actual date: 1448293880 07:51:20 INFO - 2015-11-23 07:51:20,928 INFO : starting webserver on 'localhost:49264' 07:51:20 INFO - 2015-11-23 07:51:20,930 INFO : Starting test suite t-yosemite-r5-0013 07:51:20 INFO - 2015-11-23 07:51:20,930 INFO : Starting test dromaeo_css 07:51:20 INFO - 2015-11-23 07:51:20,930 DEBUG : operating with platform_type : mac_ 07:51:20 INFO - 2015-11-23 07:51:20,931 INFO : Initialising browser for dromaeo_css test... 07:51:20 INFO - 2015-11-23 07:51:20,966 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmp4YcB8M/profile http://localhost:49264/getInfo.html 07:51:23 INFO - 2015-11-23 07:51:23,938 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:51:23 INFO - 2015-11-23 07:51:23,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:51:23 INFO - 2015-11-23 07:51:23,939 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 07:51:23 INFO - 2015-11-23 07:51:23,939 DEBUG : BROWSER_OUTPUT: __metrics 07:51:23 INFO - 2015-11-23 07:51:23,954 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:24 INFO - 2015-11-23 07:51:24,648 INFO : Browser initialized. 07:51:24 INFO - 2015-11-23 07:51:24,649 INFO : Running cycle 1/1 for dromaeo_css test... 07:51:24 INFO - 2015-11-23 07:51:24,649 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmp4YcB8M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:51:36 INFO - 2015-11-23 07:51:36,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 198635520 07:51:36 INFO - 2015-11-23 07:51:36,635 DEBUG : BROWSER_OUTPUT: 07:52:28 INFO - 2015-11-23 07:52:28,254 DEBUG : BROWSER_OUTPUT: 1448293948246 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] 07:54:38 INFO - 2015-11-23 07:54:38,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 07:54:39 INFO - 2015-11-23 07:54:39,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 291504128 07:54:39 INFO - 2015-11-23 07:54:39,599 DEBUG : BROWSER_OUTPUT: 07:57:42 INFO - 2015-11-23 07:57:42,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 07:57:42 INFO - 2015-11-23 07:57:42,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 341729280 07:57:42 INFO - 2015-11-23 07:57:42,856 DEBUG : BROWSER_OUTPUT: 08:00:44 INFO - 2015-11-23 08:00:44,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 08:00:45 INFO - 2015-11-23 08:00:45,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 341692416 08:00:45 INFO - 2015-11-23 08:00:45,547 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-11-23 08:03:47,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 08:03:48 INFO - 2015-11-23 08:03:48,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 301228032 08:03:48 INFO - 2015-11-23 08:03:48,170 DEBUG : BROWSER_OUTPUT: 08:06:51 INFO - 2015-11-23 08:06:51,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 08:06:51 INFO - 2015-11-23 08:06:51,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 301641728 08:06:51 INFO - 2015-11-23 08:06:51,862 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 08:09:54 INFO - 2015-11-23 08:09:54,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 348065792 08:09:54 INFO - 2015-11-23 08:09:54,756 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,756 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:09:54 INFO - 2015-11-23 08:09:54,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:09:54 INFO - 2015-11-23 08:09:54,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:09:54 INFO - 2015-11-23 08:09:54,757 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:09:54 INFO - 2015-11-23 08:09:54,757 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2942.5586162075674;2952.6013988111613;2961.8963336283236;2963.481390756617;3071.6160479940004;4838.250071238955;4845.7819398127085;4880.902381952359;4916.016796640668;4954.677945933517;4855.490173531773;4890.510948905107;4906.141425250585;4909.926351104737;4931.038447502739;4563.315502674601;4596.149712303235;4604.746738929358;4628.467726211478;4659.673822832387;4439.356293337464;4522.728636281817;4556.179887620227;4558.088382323532;4657.580817726404;4517.25465298227;4538.614217791492;4572.611328037105;4600.953990460102;4613.1696294666945;4516.1193567254395;4619.792109355087;4635.768211589407;4642.535746425364;4727.3618061561765;4497.842575509874;4516.18708632446;4530.569595888385;4583.793729282191;4598.241290187115;4830.855074347775;4860.489648586883;4871.732054736988;4897.363342765418;5009.574186194178;5253.816116435944;5274.815381461631;5290.867728306785;5310.468953104697;5317.229001794757;5061.848144555669;5071.771770270347;5192.376914770214;5229.607779416521;5335.6798592084215;4840.031993601294;4855.562999330042;4864.075825593126;4893.828715994994;4934;5278.683279003272;5313.229581710631;5314.229436731653;5361.705106219118;5437.755301011464;4883.121038213085;4998.05037042968;5038.244263360525;5068.949310506921;5149.897002059938;5160;5287.947120528823;5317.521423071942;5326.387465441447;5369.087255166631;5214.921776173361;5230.34620672416;5232.2413250078525;5249.632525723239;5270;4988.376452943382;5052.72210028452;5153.2785410042625;5189.299444574934;5199.896002079937;4081.285774989365;4130.958690413117;4132.5454200037975;4143.627073563333;4163.7293575917465;3736.0286325555553;3760.8683696070507;3779.3575092234387;3783.1677031053673;3788.4885540452237;4749.62003039756;4869.415670119608;4915.11527924977;4922.655414120977;4984.950150498448;5359.973200133974;5364.892702145935;5376.059189641797;5389.272448219519;5428.321459817523;4959.528844759742;4996.525330093708;5032.597392208614;5042.168042273057;5046.293518907356;4459.487158976759;4515.977420112944;4566.634669226454;4612.7001744886475;4615.26155815068;5304.496072873071;5330.546903513245;5349.438308977579;5371.543418809367;5414;5272.736363181749;5275.604329675367;5349.144136938071;5351.304330437174;5388.2725832012175;5085.364329458817;5221.843344699665;5229.947700522946;5245.763940622757;5296.3379577552805;5172.431032586488;5228.816991405282;5229.372475302988;5236.371635403776;5260.8158714446345;5318.0959236930585;5333.7866485340155;5371.140617501181;5380.569554435558;5395.78416863321;4863.537963893425;4865.221564549655;4873.585745211697;5032.899342013213;5184.118699821115;5102.540771330598;5173.81891633791;5179.792808287626;5222.060029194781;5237.135872580981;5062.721550314768;5109.131447653834;5120.078385890575;5138.306328645585;5143.974280128576;4951.232558953368;5040.395152581714;5040.798368065236;5105.7702403391195;5224.9738751306;5039.067772462106;5060.645754797129;5066.189409694432;5149.0474262261605;5167.509086636764 08:09:54 INFO - 2015-11-23 08:09:54,760 DEBUG : BROWSER_OUTPUT: |1;ext.html;526.2711145064086;527.7545941137371;530.2205757536423;537.7580088959968;558.9659130608372;29310.706892931063;30385.696143038564;36203.456948145766;37109.62890371095;37174;39444.80277598608;39977.60022399775;40095.19809603806;40121.79939100308;40150.59849401505;7817.491863028913;8352.624131914079;8493.405461617689;8509.064002959669;8518.361122915776;7997.6401061952065;10002.649907253248;10260.179185665167;10266.076053155215;10279.640212592523;10058.698239052803;10147.594096236142;10177.898221017806;10179.389236645788;10194.64318748844;8035.517868927883;8196.34429245659;9799.951000245024;10074.294799364048;10289.485525723683;9549.856752148653;9650.90349096507;9680.661176858846;9680.95159524205;9700.951495242549;34728.30543389118;35111.297774044375;35190.64809351899;35203.295934081434;35346.64653353459;2688.8386696798257;2738.2880451082665;2759.310172456886;2927.9414411711646;3121.7658675599423;25823;26015.73984260171;26474.338141546425;26493.739711677597;26652.06717764869;2121.4802373418456;2142.817860481861;2175.6518956966966;2193.1775584155944;2223.866568005925;257394;257768;259828.7008564964;260016;260921;53046.469535304925;54924.17613735797;54985;55069;55338.16992745112;64187.679061604395;65329.34670653327;65811.67094164499;65835;66447.33552664412;16164.838351616334;16315.34738610466;16335.836641633668;16489.505314840575;16492.25784839685;12472.376381180904;12480.063995200397;12493.375331233401;12631.368431578385;12642.557510487273;18092.54768630795;18256.36102736398;18275.817241827677;18292.634147317247;18333.7249941251;7883.132855385903;8100.311473524698;8155.592220388957;8170.918290817016;8208.507489550646;817.9468334558235;855.3072011670566;904.5884122724276;905.0225756183306;944.3861490031535;26248.73751262501;26278;26459.603105953425;26719.19842404731;26742.732572674024;971.32007594684;982.2240430060315;993.4238141877694;1013.8276492996208;1016.1565900302732;13708.24604646754;14052.789208161887;14641.633959151106;14900.850991490162;14984.925075374771;297702;305067;306758;307924;308694;45074.09851802946;45812.54187458083;51938;52223;55678.72160639171;1312.1012106706937;1348.3393137362818;1349.2444231230543;1349.6153596225029;1350.0414705559162;26160.60759088653;26183.73816261889;26965.595516066882;27397.31506712348;27436;41984;42865.571344287404;45712.771436142604;46603.53396465992;46953.765231173624;243556;243730;246179;246847;247710;28456.430871382043;28458;29083;29175.562366564092;29712.257193570334;36477.45283820692;37797.62202378051;37837.43243851289;38457.23085538218;39689.20621587495;31098;31196.220094497818;32347.514787277738;32742.50886236756;32899;31530.36939261156;32111;32431.675683242865;32460.83769581137;33464.665353347125;32214.692006475067;32490.512642310856;32824.671753282164;32867;32897;27451.31371715643;28315.292117696397;28754;28778;28996.130116096552;21852.715134779763;22423.32730018102;22470.775292246868;22552.323430297118;22573.32280031536 08:09:54 INFO - 2015-11-23 08:09:54,762 DEBUG : BROWSER_OUTPUT: |2;jquery.html;324.5035096302658;324.7772137900802;327.9442494775888;328.2221135907899;334.096269590757;9683.402238630617;10073.395596264229;11216.214864959446;16147.111908845009;16711.331546738133;9938.204943604513;10433.686989390311;10649.840252396201;10708.732281692943;11076.335419874813;4051.270771261172;4163.125743593849;4164.396162556428;4173.749575025493;4188.308929026707;3311.3873933322293;3401.404754168023;4160.105577300879;4287.764172970486;4495.213337665896;4470.932936005963;4476.574725401098;4501.077279157765;4506.504284528699;4507.143642707875;4289.806958686867;4434.135343607998;4441.88895277619;4458.910821783578;4482.417285752831;3769.1142581493327;3797.2025874566098;3812.0088776917923;3812.2566099610585;3842.7886466244345;12590.874091259062;12887.484500619965;12938.353082345939;12960;13006.544770932973;1719.4325872462057;1726.7064599018197;1750.2473936207425;1791.1402526787215;1831.542114471382;8844.911550884537;9008.234300084501;9106.81786364269;9151.588178531982;9610.95194524023;1436.9281535923267;1445.551878917539;1445.6602698365875;1452.7675571908444;1493.2906869237133;55594;57134.714326428104;57944.42055579432;58032.70983645055;58066.70966645182;6183.81448556544;6187.628742275388;6190.071489276645;6293.496520278367;6337.366263373626;7246.166690830517;7255.673494692752;7297.89053164203;7321.524100933529;7325.816854578572;5304.310439642822;5373.838784836461;5374.167004114369;5390.595705322116;5405.594580406485;5690.971545142331;5715.2855893013375;5751.626144300607;5786.826395208151;5794;2777.819441736321;2792.399634078642;2814.7044560321283;2829.462402143586;2830.7452329290463;972.1590823937244;974.5078735238659;1032.3135115148343;1044.8798388185303;1074.752806854428;388.9883303500843;395.43452862407037;403.4553352973462;403.70126106680846;411.36444193720774;8972.910270897339;9707.46608936501;10277.434741089312;10295.176385889112;10459.163266938778;412.16947850082107;412.7709121437631;417.1906501387299;434.73263942675027;434.9956500435018;5584;5730.684812335278;6085.695715214221;6090.69546522681;6221.3156552779155;571717;596790;605165;608217;618105;67421;68157.65921170362;68454.65772671104;68941.65529172422;69527.3047269531;479.4179208611568;479.75052972454824;481.8940531480261;482.519892706752;487.0842815506825;10100.242481813746;10158.085772280234;10170.79658406813;10283.84574231402;10311.213519190851;33591.49612755762;33734.49398258979;33860.49209261814;33955.32089358248;34346.48480272848;45521;45702;46052.7697361511;46163.76918115388;46739.766301169635;5885.970570147122;5922.378150294157;5953.76184952597;5972.492338151305;5993.61041532299;10951.83572246401;10999.175061870232;11220.495077721685;11241.269317494663;11251.212415130862;9394.107559781809;9506.95246523763;9615.711528654152;9643.662471813454;9669.951650241705;9299.814003720023;9320.72037838866;9339.486328252011;9368.016358282282;9505.19205867509;7886.211378862297;8176.345892328481;8944;9298.395604285699;9567.186789123003;5605.5795815313195;5747.453991870766;5831.271091113611;5870.031444811559;5872.882542349214;8996.370254082412;9079;9187.310951678784;9423.19902808269;9490.762730931781 08:09:54 INFO - 2015-11-23 08:09:54,763 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1199.9680274963534;1309.908306418551;1318.3342412081897;1406.3601061517004;1727.6976529107403;6687;6919.515633905628;7222.674979625923;7381.926180738191;7383.372413344859;7123.608201548913;7196.820079498015;7243.05840240768;7264.854702905939;7384.187739348681;2021.413790000898;2026.5845501672195;2053.938381848547;2055.188200660738;2059.0528356955742;2049.8155166035053;2072.2436310746543;2073.6682130859067;2099.6430606796803;2111.7571479279927;2025.817676409123;2029.1173339597249;2031.0454086579284;2044.4377796106041;2045.3454894433787;2025.7467816522935;2037.500812300981;2055.9383218503467;2057.5370541628163;2059.3101311060814;2002.5394159343432;2027.9290224842207;2037.327681864981;2042.3056160905214;2053.712480252766;6492.935070649328;7086.114235720535;7221.4944953853255;7253.673584688701;7259.165196002475;3999.060220848098;4298.849540266076;4379.233634114049;4382.4741031076155;4399.010222699867;2618.8297760645687;2639.802014848875;2682.5976103584617;2699.743524365182;2727.0046433051994;823.4565186976627;829.1956801902145;1369.6370461827623;1377.6073818961547;1446.6455718348966;9529.666461673809;9723.708288751348;9757.512124393823;9773.755656108584;9773.804523909554;3753.136778540896;3760;3872.8063596820048;3874.845006199777;3882.398228274622;7876.803079923047;7898.2891539761695;7913.32736717374;7922.603869806602;7934.880976785353;4422.800973956179;4425.380446737459;4430.180416622935;4435.6895017349125;4468.128714900628;4073.1446396256524;4089.3252613319064;4097.344424892003;4098.549159592442;4100.446439730598;3167.160702413862;3179.60254968129;3206.5350524174332;3234.8059116453087;3243.789153705002;957.7366224288377;958.7794807194384;962.9566669499749;969.1326262994721;970.1268858027831;1116.5310569560804;1133.3200079951962;1137.7155711072232;1138.920275580718;1178.8467499225046;6626.436752875963;6703.765368212089;6715.3620406061345;6742.595444273359;6771.559848609824;422.63442122564373;423.2085999181489;425.9105587826591;426.413681188366;426.4328443170576;5141.871453213699;5198.662086964411;5202.7918883245;5210.739463026834;5229.111051121318;8177.836443271101;8506.617202225914;8585.656573737106;8620.612072456754;8686.087960764155;8491.235788778917;8539.658413663385;8659.913400866037;8681.348898832486;8682.6092825823;6927.134108236471;7001.089858318488;7019.19279282889;7025.859482810315;7034.331738484836;6828.214755303005;6930.06444130036;7015.508914375945;7023.578585284899;7038;7715.922840771745;7927.960360198393;7969.561674107979;7988.92011079905;8002.599870006593;7876.251756083163;8056.556889370906;8115.715949941724;8133.877991830009;8150.75547733569;6278.529110316836;6582.308857569887;6593.670316484253;6600.80197594073;6626.204855417381;7065.505414620927;7087.964560177373;7096.964515177391;7107.218205997233;7128.144622645315;6473.741050357933;6607;6611.966940165268;6708.530402871752;6725.361090696376;6532.608043517404;6537.542372034102;6594.769183078569;6605.240397354366;6618.305077966744;6347.460465860454;6365.077063825626;6381.042843573501;6389.808305750835;6435.485161187;5884.235049443545;5905.675187864708;5906.763729450774;5912.852178695567;5915.526757859447;5933.2880054393745;5980.192673988956;5991.101334799815;6000.21997140369;6001.969990150022 08:09:54 INFO - 2015-11-23 08:09:54,767 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.5951476234939;307.9414911166878;309.4522694830151;313.78348939231915;316.90017644442014;5567;5605.411431799658;5645.689487078209;5690.146478028298;5828.562857785667;5577.21918931349;5593.74828132734;5617.859553511164;5635.3237611486575;5636.126400407943;4247.5964783345535;4390.385346051556;4394.274944634131;4400.471943366792;4407.955920440802;4253.829846806124;4279.572042795727;4281.871543853674;4301.462317210348;4313.741175529462;4218.4516012918275;4224.176285624305;4229.259879521087;4266.104118135196;4273.401723758676;4241.321388577828;4247.193033323674;4247.68142389322;4248.065425606362;4263.126059157897;3567.8216089195435;3595.694365978869;3595.856165753367;3601.405768048269;3612.6567976042234;5307.946920530784;5442.346918369821;5492.231087647732;5525.889482210374;5533.280673512458;4567.794449249792;4682.695624784412;4692.906141877177;4716.080364328923;4731.621470282369;5602.467765562265;5838.095095260242;5851.093080572518;5855.677937713424;5877.9412205877825;3887.611238876118;3924.50943632046;3964.4251583520518;3964.643182113595;3979.045029193002;6021.939780602225;6129.938700612981;6130.908036379458;6160.4455598995855;6164.568480206387;3992.5208974923194;4017.5379831319774;4028.879133625996;4029.4761680981283;4035.1727895781296;4008.9198216036098;4072.979635101865;4098.344264917599;4106.055607210358;4111.424400583921;4796.1127191468995;4827.179379505493;4832.299316599074;4835.274708793709;4847.297141914402;5927.31835838884;5929.644221346733;5946.137810017523;5952.285725712855;5957.434043765836;1423.8504956979368;1456.978145327821;1478.0540454109378;1487.1300289330645;1490.7465730825786;925.8564922437033;952.7237101240701;955.9665411710557;959.5921733263335;973.5375696544227;5705.429457054262;5708.286464191976;5715.085586306171;5721.8569535761935;5788.942110578924;6156.907646385308;6162.044883043135;6170.382961703794;6177.351378105234;6200.56596038282;5635.774569017193;5708.1723150143;5716;5730.455606717355;5757.251557297608;3238.6761323867427;3380.2056516718553;3397.7451691123265;3402.9829850850588;3408.7954722716718;6218.5647004710145;6230.408111229426;6249.437550620466;6257.5932564383165;6283.59156654816;6322.652254126067;6336.6831658416895;6343.111964324999;6391.744330226739;6395.42441180296;6072.21061262042;6204.038374052029;6219.875602487925;6231.813045608639;6247.9062814057825;6121.204243448323;6148.323684394623;6183.350748171557;6184.567080304516;6222.719977600928;5891.587588868738;5986.2217911671205;5995.820125396245;6049.969750151221;6057.818265452043;6178.320384757583;6225.657588832658;6232.501399888089;6240.656763878031;6243.469305108935;3881.9223615526967;3907.9804600976813;3912.980435097806;3918.000909767991;3919.3729003359326;5748.367679555329;6122.4795892347865;6143.96928015357;6187.3503282154725;6210.3168651449205;6023.548233882389;6040.244969378828;6061.39386061408;6063.605865618721;6087.05650624154;6039.607425517327;6052.213212282375;6067.817965461043;6073.969630151821;6143.1706719592285;5711.685857277889;5800.419958004166;5912.438318359749;5919.171316015847;5955.315138758925;5991;6009.819705408845;6014.8195554133445;6026.126211699191;6029.909551356821;5869.266341707286;5881.970590147193;5887.205227294432;5896.115582662635;5896.469317761251 08:09:54 INFO - 2015-11-23 08:09:54,767 DEBUG : BROWSER_OUTPUT: |5;yui.html;627.667336311755;639.3382848751543;695.4992405468063;713.3864876206459;732.3152852083302;12208.877911220885;12507.187032842881;12521.937390313047;12538.435770390332;12591.181573197759;12327.63017109486;12396.628101156957;12413.689657758561;12990;13384.59846204613;662.3674390956625;667.232682415224;816.5468165168329;824.7443292579289;827.7392621324294;802.0736049862418;812.378530424223;817.5585184000632;818.758466252454;819.1276290750361;840.64272684109;844.7423535821572;846.0397448895517;849.6389034660275;849.9787505312355;695.7043256615943;700.5481464455423;845.3110714767506;848.868425394065;860.3332417376521;612.7885879371654;616.1374076293181;617.1329282358294;619.6994457688018;624.6720471752321;12554.309512976783;12571.811422828665;12582;12595.811062834066;12601.810972835416;8682.956585217096;8797.208251257354;8835.293176545925;9038.86441703375;9181.081891810833;7988;8146.266835984789;8161.55111468869;8485.533295668736;8519;2590.9870450647813;2616.6205900144373;2624.5931880558355;2676.2907829425217;2712.620233167358;44381.33427998583;44462.77768611169;44574.77712611416;44926.10147797026;45069.549304506865;6163.167972323679;6203.906941395882;6208.0998255253635;6211.472024877936;6316.747330106744;10841.403722795165;10875.564977400816;10883.83674244887;10915.890841091647;11704.239224450383;5538.889222215533;5562.554995600342;5638.718064096779;5766.308043034863;5855.853603659857;3443.5523381960184;3469.591226321037;3562.59030211529;3584.534010578608;3592.191756854687;2401.8198635102435;2426.7451917548756;2429.4290841652196;2432.1487479382076;2470.864102474345;375.7632691404398;376.5368596626165;379.16394350457176;380.0498753117207;381.0264773503725;435.83873966631916;483.2919772533185;483.9008003359303;495.4970704734697;524.8268071536384;6642;6729.798106056826;6781.186257649015;6792.184937807495;7257.52826066304;430.91381723655394;440.87655456472237;474.5373261070429;478.32794923133054;509.57195955397646;3119.8833912383707;3446.4485682291215;3452.9482057769155;3598.1724203433355;3832.616738326145;54368.18447723287;54496;54716.179257311174;54727;54896.176557351675;46794.76602616965;46910.06179876383;47512.28731569029;47549.76225118852;48343.5165648339;45473.09053818971;46823.53176468192;47392.28911566329;47459.76270118627;47584.5241547587;7251.709931602677;7297.233790451926;7319.817004574928;7351.191368949519;7579.052618422697;32860.1784955378;33025;33432.1641958953;33704;33989;45291.54708453005;45341;45709;45764.31353529633;46045.76977115093;6727.226368967631;6843.520953533205;6881.483888708267;6986.091808064919;7146.678399471933;10253;10336.534855931352;10403.94798026005;10547.736306592396;11055.0603198729;8955;9206.953965230132;9702.563384647567;9910.058544438267;10031.598736050477;9939.403635781877;9963.302568820112;10005.099541041342;10069.647562335284;10086.495675216063;9421.434713917188;9635.325527213028;9654.806903861743;9679.903200968181;9696.418214907128;8752.912470875464;8781.912180878366;8838.116188381367;8898.065703101081;9050;8321.95839020801;8662.653493860174;8722.171393717586;8767.517786521803;8943.23982461498 08:09:54 INFO - 2015-11-23 08:09:54,768 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:09:54 INFO - 2015-11-23 08:09:54,768 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:09:54 INFO - 2015-11-23 08:09:54,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1008 08:09:54 INFO - 2015-11-23 08:09:54,768 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:09:54 INFO - 2015-11-23 08:09:54,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1448294994754__endTimestamp 08:09:54 INFO - 2015-11-23 08:09:54,769 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,769 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:09:54 INFO - 2015-11-23 08:09:54,769 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:09:54 INFO - 2015-11-23 08:09:54,769 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,770 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4896.21 Median:5039.07 stddev:503.60 (10.0%) stddev-sans-first:481.26 08:09:54 INFO - 2015-11-23 08:09:54,771 DEBUG : BROWSER_OUTPUT: Values: 2942.6 2952.6 2961.9 2963.5 3071.6 4838.3 4845.8 4880.9 4916.0 4954.7 4855.5 4890.5 4906.1 4909.9 4931.0 4563.3 4596.1 4604.7 4628.5 4659.7 4439.4 4522.7 4556.2 4558.1 4657.6 4517.3 4538.6 4572.6 4601.0 4613.2 4516.1 4619.8 4635.8 4642.5 4727.4 4497.8 4516.2 4530.6 4583.8 4598.2 4830.9 4860.5 4871.7 4897.4 5009.6 5253.8 5274.8 5290.9 5310.5 5317.2 5061.8 5071.8 5192.4 5229.6 5335.7 4840.0 4855.6 4864.1 4893.8 4934.0 5278.7 5313.2 5314.2 5361.7 5437.8 4883.1 4998.1 5038.2 5068.9 5149.9 5160.0 5287.9 5317.5 5326.4 5369.1 5214.9 5230.3 5232.2 5249.6 5270.0 4988.4 5052.7 5153.3 5189.3 5199.9 4081.3 4131.0 4132.5 4143.6 4163.7 3736.0 3760.9 3779.4 3783.2 3788.5 4749.6 4869.4 4915.1 4922.7 4985.0 5360.0 5364.9 5376.1 5389.3 5428.3 4959.5 4996.5 5032.6 5042.2 5046.3 4459.5 4516.0 4566.6 4612.7 4615.3 5304.5 5330.5 5349.4 5371.5 5414.0 5272.7 5275.6 5349.1 5351.3 5388.3 5085.4 5221.8 5229.9 5245.8 5296.3 5172.4 5228.8 5229.4 5236.4 5260.8 5318.1 5333.8 5371.1 5380.6 5395.8 4863.5 4865.2 4873.6 5032.9 5184.1 5102.5 5173.8 5179.8 5222.1 5237.1 5062.7 5109.1 5120.1 5138.3 5144.0 4951.2 5040.4 5040.8 5105.8 5225.0 5039.1 5060.6 5066.2 5149.0 5167.5 08:09:54 INFO - 2015-11-23 08:09:54,771 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,771 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43182.13 Median:305912.50 stddev:70856.60 (23.2%) stddev-sans-first:70982.99 08:09:54 INFO - 2015-11-23 08:09:54,771 DEBUG : BROWSER_OUTPUT: Values: 526.3 527.8 530.2 537.8 559.0 29310.7 30385.7 36203.5 37109.6 37174.0 39444.8 39977.6 40095.2 40121.8 40150.6 7817.5 8352.6 8493.4 8509.1 8518.4 7997.6 10002.6 10260.2 10266.1 10279.6 10058.7 10147.6 10177.9 10179.4 10194.6 8035.5 8196.3 9800.0 10074.3 10289.5 9549.9 9650.9 9680.7 9681.0 9701.0 34728.3 35111.3 35190.6 35203.3 35346.6 2688.8 2738.3 2759.3 2927.9 3121.8 25823.0 26015.7 26474.3 26493.7 26652.1 2121.5 2142.8 2175.7 2193.2 2223.9 257394.0 257768.0 259828.7 260016.0 260921.0 53046.5 54924.2 54985.0 55069.0 55338.2 64187.7 65329.3 65811.7 65835.0 66447.3 16164.8 16315.3 16335.8 16489.5 16492.3 12472.4 12480.1 12493.4 12631.4 12642.6 18092.5 18256.4 18275.8 18292.6 18333.7 7883.1 8100.3 8155.6 8170.9 8208.5 817.9 855.3 904.6 905.0 944.4 26248.7 26278.0 26459.6 26719.2 26742.7 971.3 982.2 993.4 1013.8 1016.2 13708.2 14052.8 14641.6 14900.9 14984.9 297702.0 305067.0 306758.0 307924.0 308694.0 45074.1 45812.5 51938.0 52223.0 55678.7 1312.1 1348.3 1349.2 1349.6 1350.0 26160.6 26183.7 26965.6 27397.3 27436.0 41984.0 42865.6 45712.8 46603.5 46953.8 243556.0 243730.0 246179.0 246847.0 247710.0 28456.4 28458.0 29083.0 29175.6 29712.3 36477.5 37797.6 37837.4 38457.2 39689.2 31098.0 31196.2 32347.5 32742.5 32899.0 31530.4 32111.0 32431.7 32460.8 33464.7 32214.7 32490.5 32824.7 32867.0 32897.0 27451.3 28315.3 28754.0 28778.0 28996.1 21852.7 22423.3 22470.8 22552.3 22573.3 08:09:54 INFO - 2015-11-23 08:09:54,772 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,773 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27532.16 Median:45877.38 stddev:98277.18 (214.2%) stddev-sans-first:98531.64 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: Values: 324.5 324.8 327.9 328.2 334.1 9683.4 10073.4 11216.2 16147.1 16711.3 9938.2 10433.7 10649.8 10708.7 11076.3 4051.3 4163.1 4164.4 4173.7 4188.3 3311.4 3401.4 4160.1 4287.8 4495.2 4470.9 4476.6 4501.1 4506.5 4507.1 4289.8 4434.1 4441.9 4458.9 4482.4 3769.1 3797.2 3812.0 3812.3 3842.8 12590.9 12887.5 12938.4 12960.0 13006.5 1719.4 1726.7 1750.2 1791.1 1831.5 8844.9 9008.2 9106.8 9151.6 9611.0 1436.9 1445.6 1445.7 1452.8 1493.3 55594.0 57134.7 57944.4 58032.7 58066.7 6183.8 6187.6 6190.1 6293.5 6337.4 7246.2 7255.7 7297.9 7321.5 7325.8 5304.3 5373.8 5374.2 5390.6 5405.6 5691.0 5715.3 5751.6 5786.8 5794.0 2777.8 2792.4 2814.7 2829.5 2830.7 972.2 974.5 1032.3 1044.9 1074.8 389.0 395.4 403.5 403.7 411.4 8972.9 9707.5 10277.4 10295.2 10459.2 412.2 412.8 417.2 434.7 435.0 5584.0 5730.7 6085.7 6090.7 6221.3 571717.0 596790.0 605165.0 608217.0 618105.0 67421.0 68157.7 68454.7 68941.7 69527.3 479.4 479.8 481.9 482.5 487.1 10100.2 10158.1 10170.8 10283.8 10311.2 33591.5 33734.5 33860.5 33955.3 34346.5 45521.0 45702.0 46052.8 46163.8 46739.8 5886.0 5922.4 5953.8 5972.5 5993.6 10951.8 10999.2 11220.5 11241.3 11251.2 9394.1 9507.0 9615.7 9643.7 9670.0 9299.8 9320.7 9339.5 9368.0 9505.2 7886.2 8176.3 8944.0 9298.4 9567.2 5605.6 5747.5 5831.3 5870.0 5872.9 8996.4 9079.0 9187.3 9423.2 9490.8 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5027.85 Median:6373.06 stddev:2640.53 (41.4%) stddev-sans-first:2632.26 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: Values: 1200.0 1309.9 1318.3 1406.4 1727.7 6687.0 6919.5 7222.7 7381.9 7383.4 7123.6 7196.8 7243.1 7264.9 7384.2 2021.4 2026.6 2053.9 2055.2 2059.1 2049.8 2072.2 2073.7 2099.6 2111.8 2025.8 2029.1 2031.0 2044.4 2045.3 2025.7 2037.5 2055.9 2057.5 2059.3 2002.5 2027.9 2037.3 2042.3 2053.7 6492.9 7086.1 7221.5 7253.7 7259.2 3999.1 4298.8 4379.2 4382.5 4399.0 2618.8 2639.8 2682.6 2699.7 2727.0 823.5 829.2 1369.6 1377.6 1446.6 9529.7 9723.7 9757.5 9773.8 9773.8 3753.1 3760.0 3872.8 3874.8 3882.4 7876.8 7898.3 7913.3 7922.6 7934.9 4422.8 4425.4 4430.2 4435.7 4468.1 4073.1 4089.3 4097.3 4098.5 4100.4 3167.2 3179.6 3206.5 3234.8 3243.8 957.7 958.8 963.0 969.1 970.1 1116.5 1133.3 1137.7 1138.9 1178.8 6626.4 6703.8 6715.4 6742.6 6771.6 422.6 423.2 425.9 426.4 426.4 5141.9 5198.7 5202.8 5210.7 5229.1 8177.8 8506.6 8585.7 8620.6 8686.1 8491.2 8539.7 8659.9 8681.3 8682.6 6927.1 7001.1 7019.2 7025.9 7034.3 6828.2 6930.1 7015.5 7023.6 7038.0 7715.9 7928.0 7969.6 7988.9 8002.6 7876.3 8056.6 8115.7 8133.9 8150.8 6278.5 6582.3 6593.7 6600.8 6626.2 7065.5 7088.0 7097.0 7107.2 7128.1 6473.7 6607.0 6612.0 6708.5 6725.4 6532.6 6537.5 6594.8 6605.2 6618.3 6347.5 6365.1 6381.0 6389.8 6435.5 5884.2 5905.7 5906.8 5912.9 5915.5 5933.3 5980.2 5991.1 6000.2 6002.0 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,775 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4935.58 Median:5715.54 stddev:1519.64 (26.6%) stddev-sans-first:1483.48 08:09:54 INFO - 2015-11-23 08:09:54,777 DEBUG : BROWSER_OUTPUT: Values: 296.6 307.9 309.5 313.8 316.9 5567.0 5605.4 5645.7 5690.1 5828.6 5577.2 5593.7 5617.9 5635.3 5636.1 4247.6 4390.4 4394.3 4400.5 4408.0 4253.8 4279.6 4281.9 4301.5 4313.7 4218.5 4224.2 4229.3 4266.1 4273.4 4241.3 4247.2 4247.7 4248.1 4263.1 3567.8 3595.7 3595.9 3601.4 3612.7 5307.9 5442.3 5492.2 5525.9 5533.3 4567.8 4682.7 4692.9 4716.1 4731.6 5602.5 5838.1 5851.1 5855.7 5877.9 3887.6 3924.5 3964.4 3964.6 3979.0 6021.9 6129.9 6130.9 6160.4 6164.6 3992.5 4017.5 4028.9 4029.5 4035.2 4008.9 4073.0 4098.3 4106.1 4111.4 4796.1 4827.2 4832.3 4835.3 4847.3 5927.3 5929.6 5946.1 5952.3 5957.4 1423.9 1457.0 1478.1 1487.1 1490.7 925.9 952.7 956.0 959.6 973.5 5705.4 5708.3 5715.1 5721.9 5788.9 6156.9 6162.0 6170.4 6177.4 6200.6 5635.8 5708.2 5716.0 5730.5 5757.3 3238.7 3380.2 3397.7 3403.0 3408.8 6218.6 6230.4 6249.4 6257.6 6283.6 6322.7 6336.7 6343.1 6391.7 6395.4 6072.2 6204.0 6219.9 6231.8 6247.9 6121.2 6148.3 6183.4 6184.6 6222.7 5891.6 5986.2 5995.8 6050.0 6057.8 6178.3 6225.7 6232.5 6240.7 6243.5 3881.9 3908.0 3913.0 3918.0 3919.4 5748.4 6122.5 6144.0 6187.4 6210.3 6023.5 6040.2 6061.4 6063.6 6087.1 6039.6 6052.2 6067.8 6074.0 6143.2 5711.7 5800.4 5912.4 5919.2 5955.3 5991.0 6009.8 6014.8 6026.1 6029.9 5869.3 5882.0 5887.2 5896.1 5896.5 08:09:54 INFO - 2015-11-23 08:09:54,777 DEBUG : BROWSER_OUTPUT: 08:09:54 INFO - 2015-11-23 08:09:54,777 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12413.86 Median:54606.09 stddev:15537.00 (28.5%) stddev-sans-first:15555.37 08:09:54 INFO - 2015-11-23 08:09:54,777 DEBUG : BROWSER_OUTPUT: Values: 627.7 639.3 695.5 713.4 732.3 12208.9 12507.2 12521.9 12538.4 12591.2 12327.6 12396.6 12413.7 12990.0 13384.6 662.4 667.2 816.5 824.7 827.7 802.1 812.4 817.6 818.8 819.1 840.6 844.7 846.0 849.6 850.0 695.7 700.5 845.3 848.9 860.3 612.8 616.1 617.1 619.7 624.7 12554.3 12571.8 12582.0 12595.8 12601.8 8683.0 8797.2 8835.3 9038.9 9181.1 7988.0 8146.3 8161.6 8485.5 8519.0 2591.0 2616.6 2624.6 2676.3 2712.6 44381.3 44462.8 44574.8 44926.1 45069.5 6163.2 6203.9 6208.1 6211.5 6316.7 10841.4 10875.6 10883.8 10915.9 11704.2 5538.9 5562.6 5638.7 5766.3 5855.9 3443.6 3469.6 3562.6 3584.5 3592.2 2401.8 2426.7 2429.4 2432.1 2470.9 375.8 376.5 379.2 380.0 381.0 435.8 483.3 483.9 495.5 524.8 6642.0 6729.8 6781.2 6792.2 7257.5 430.9 440.9 474.5 478.3 509.6 3119.9 3446.4 3452.9 3598.2 3832.6 54368.2 54496.0 54716.2 54727.0 54896.2 46794.8 46910.1 47512.3 47549.8 48343.5 45473.1 46823.5 47392.3 47459.8 47584.5 7251.7 7297.2 7319.8 7351.2 7579.1 32860.2 33025.0 33432.2 33704.0 33989.0 45291.5 45341.0 45709.0 45764.3 46045.8 6727.2 6843.5 6881.5 6986.1 7146.7 10253.0 10336.5 10403.9 10547.7 11055.1 8955.0 9207.0 9702.6 9910.1 10031.6 9939.4 9963.3 10005.1 10069.6 10086.5 9421.4 9635.3 9654.8 9679.9 9696.4 8752.9 8781.9 8838.1 8898.1 9050.0 8322.0 8662.7 8722.2 8767.5 8943.2 08:09:54 INFO - 2015-11-23 08:09:54,777 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:09:54 INFO - 2015-11-23 08:09:54,778 DEBUG : BROWSER_OUTPUT: 08:09:55 INFO - 2015-11-23 08:09:55,203 INFO : Browser exited with error code: 0 08:09:55 INFO - 2015-11-23 08:09:55,233 INFO : Completed test dromaeo_css (00:18:34) 08:09:55 INFO - 2015-11-23 08:09:55,233 INFO : Starting test kraken 08:09:55 INFO - 2015-11-23 08:09:55,233 DEBUG : operating with platform_type : mac_ 08:09:55 INFO - 2015-11-23 08:09:55,234 INFO : Initialising browser for kraken test... 08:09:55 INFO - 2015-11-23 08:09:55,248 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpvGLj9A/profile http://localhost:49264/getInfo.html 08:09:57 INFO - 2015-11-23 08:09:57,587 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:09:57 INFO - 2015-11-23 08:09:57,587 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:09:57 INFO - 2015-11-23 08:09:57,587 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:09:57 INFO - 2015-11-23 08:09:57,587 DEBUG : BROWSER_OUTPUT: __metrics 08:09:57 INFO - 2015-11-23 08:09:57,603 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:58 INFO - 2015-11-23 08:09:58,270 INFO : Browser initialized. 08:09:58 INFO - 2015-11-23 08:09:58,270 INFO : Running cycle 1/1 for kraken test... 08:09:58 INFO - 2015-11-23 08:09:58,270 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpvGLj9A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:10:10 INFO - 2015-11-23 08:10:10,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 198942720 08:10:10 INFO - 2015-11-23 08:10:10,219 DEBUG : BROWSER_OUTPUT: 08:10:12 INFO - 2015-11-23 08:10:12,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 08:10:13 INFO - 2015-11-23 08:10:13,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 265826304 08:10:13 INFO - 2015-11-23 08:10:13,427 DEBUG : BROWSER_OUTPUT: 08:10:16 INFO - 2015-11-23 08:10:16,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 08:10:16 INFO - 2015-11-23 08:10:16,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 279912448 08:10:16 INFO - 2015-11-23 08:10:16,826 DEBUG : BROWSER_OUTPUT: 08:10:19 INFO - 2015-11-23 08:10:19,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 08:10:20 INFO - 2015-11-23 08:10:20,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 269135872 08:10:20 INFO - 2015-11-23 08:10:20,428 DEBUG : BROWSER_OUTPUT: 08:10:22 INFO - 2015-11-23 08:10:22,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 08:10:23 INFO - 2015-11-23 08:10:23,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 270774272 08:10:23 INFO - 2015-11-23 08:10:23,219 DEBUG : BROWSER_OUTPUT: 08:10:25 INFO - 2015-11-23 08:10:25,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:10:26 INFO - 2015-11-23 08:10:26,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 270364672 08:10:26 INFO - 2015-11-23 08:10:26,125 DEBUG : BROWSER_OUTPUT: 08:10:29 INFO - 2015-11-23 08:10:29,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 08:10:29 INFO - 2015-11-23 08:10:29,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 270450688 08:10:29 INFO - 2015-11-23 08:10:29,976 DEBUG : BROWSER_OUTPUT: 08:10:33 INFO - 2015-11-23 08:10:33,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 08:10:33 INFO - 2015-11-23 08:10:33,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 271056896 08:10:33 INFO - 2015-11-23 08:10:33,930 DEBUG : BROWSER_OUTPUT: 08:10:37 INFO - 2015-11-23 08:10:37,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 08:10:37 INFO - 2015-11-23 08:10:37,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 269639680 08:10:37 INFO - 2015-11-23 08:10:37,624 DEBUG : BROWSER_OUTPUT: 08:10:39 INFO - 2015-11-23 08:10:39,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:39 INFO - 2015-11-23 08:10:39,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 301486080 08:10:39 INFO - 2015-11-23 08:10:39,888 DEBUG : BROWSER_OUTPUT: 08:10:41 INFO - 2015-11-23 08:10:41,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:42 INFO - 2015-11-23 08:10:42,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 303624192 08:10:42 INFO - 2015-11-23 08:10:42,437 DEBUG : BROWSER_OUTPUT: 08:10:44 INFO - 2015-11-23 08:10:44,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:10:45 INFO - 2015-11-23 08:10:45,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 309415936 08:10:45 INFO - 2015-11-23 08:10:45,196 DEBUG : BROWSER_OUTPUT: 08:10:47 INFO - 2015-11-23 08:10:47,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:10:48 INFO - 2015-11-23 08:10:48,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 311324672 08:10:48 INFO - 2015-11-23 08:10:48,547 DEBUG : BROWSER_OUTPUT: 08:10:51 INFO - 2015-11-23 08:10:51,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:51 INFO - 2015-11-23 08:10:51,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 310452224 08:10:51 INFO - 2015-11-23 08:10:51,875 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 08:10:53 INFO - 2015-11-23 08:10:53,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 369463296 08:10:53 INFO - 2015-11-23 08:10:53,943 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,943 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;107;109;109;109;110;113;118;118;111 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;145;177;172;144;164;140;174;164;137 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;176;179;179;175;174;174;181;180;174 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;85;100;156;78;77;79;77;126;76 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;110;151;99;102;100;142;98;99;146 08:10:53 INFO - 2015-11-23 08:10:53,944 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;131;130;129;130;136;129;136;129;128;130 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;140;140;140;140;140;133;140;141;140 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;113;112;114;113;117;114;114;113;114 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;65;69;68;71;71;71;80;64;67 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;71;71;75;76;75;75;77;75;75 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;87;93;91;91;92;91;91;93;97 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;135;137;137;140;146;135;142;142;141 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;163;165;164;162;152;164;165;149;159 08:10:53 INFO - 2015-11-23 08:10:53,945 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;73;73;78;78;77;77;79;77;77 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,891 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: __startTimestamp1448295053936__endTimestamp 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:10:53 INFO - 2015-11-23 08:10:53,946 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:3.81 (3.4%) stddev-sans-first:4.00 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: Values: 110.0 107.0 109.0 109.0 109.0 110.0 113.0 118.0 118.0 111.0 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:158.20 Median:164.50 stddev:15.14 (9.2%) stddev-sans-first:15.86 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: Values: 165.0 145.0 177.0 172.0 144.0 164.0 140.0 174.0 164.0 137.0 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:176.40 Median:177.50 stddev:3.10 (1.7%) stddev-sans-first:2.85 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: Values: 172.0 176.0 179.0 179.0 175.0 174.0 174.0 181.0 180.0 174.0 08:10:53 INFO - 2015-11-23 08:10:53,947 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.30 Median:77.50 stddev:27.06 (34.9%) stddev-sans-first:28.20 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: Values: 79.0 85.0 100.0 156.0 78.0 77.0 79.0 77.0 126.0 76.0 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.10 Median:148.50 stddev:21.93 (14.8%) stddev-sans-first:22.89 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: Values: 104.0 110.0 151.0 99.0 102.0 100.0 142.0 98.0 99.0 146.0 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:130.80 Median:130.00 stddev:2.86 (2.2%) stddev-sans-first:3.03 08:10:53 INFO - 2015-11-23 08:10:53,948 DEBUG : BROWSER_OUTPUT: Values: 131.0 130.0 129.0 130.0 136.0 129.0 136.0 129.0 128.0 130.0 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:139.40 Median:140.00 stddev:2.27 (1.6%) stddev-sans-first:2.40 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: Values: 140.0 140.0 140.0 140.0 140.0 140.0 133.0 140.0 141.0 140.0 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.70 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 112.0 114.0 113.0 117.0 114.0 114.0 113.0 114.0 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.30 Median:70.00 stddev:5.95 (8.5%) stddev-sans-first:4.69 08:10:53 INFO - 2015-11-23 08:10:53,949 DEBUG : BROWSER_OUTPUT: Values: 57.0 65.0 69.0 68.0 71.0 71.0 71.0 80.0 64.0 67.0 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.10 Median:75.00 stddev:2.23 (3.0%) stddev-sans-first:2.07 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 75.0 76.0 75.0 75.0 77.0 75.0 75.0 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:91.50 stddev:3.73 (4.1%) stddev-sans-first:2.64 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 93.0 91.0 91.0 92.0 91.0 91.0 93.0 97.0 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,950 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:140.50 stddev:3.67 (2.6%) stddev-sans-first:3.71 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 137.0 137.0 140.0 146.0 135.0 142.0 142.0 141.0 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:163.50 stddev:5.83 (3.6%) stddev-sans-first:5.92 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: Values: 155.0 163.0 165.0 164.0 162.0 152.0 164.0 165.0 149.0 159.0 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:77.00 stddev:3.12 (4.1%) stddev-sans-first:2.13 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 73.0 78.0 78.0 77.0 77.0 79.0 77.0 77.0 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:10:53 INFO - 2015-11-23 08:10:53,951 DEBUG : BROWSER_OUTPUT: 08:10:54 INFO - 2015-11-23 08:10:54,622 INFO : Browser exited with error code: 0 08:10:54 INFO - 2015-11-23 08:10:54,676 INFO : Completed test kraken (00:00:59) 08:10:54 INFO - 2015-11-23 08:10:54,676 INFO : Starting test v8_7 08:10:54 INFO - 2015-11-23 08:10:54,676 DEBUG : operating with platform_type : mac_ 08:10:54 INFO - 2015-11-23 08:10:54,676 INFO : Initialising browser for v8_7 test... 08:10:54 INFO - 2015-11-23 08:10:54,690 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpjQkNNE/profile http://localhost:49264/getInfo.html 08:10:57 INFO - 2015-11-23 08:10:57,071 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:10:57 INFO - 2015-11-23 08:10:57,071 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:10:57 INFO - 2015-11-23 08:10:57,071 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:10:57 INFO - 2015-11-23 08:10:57,071 DEBUG : BROWSER_OUTPUT: __metrics 08:10:57 INFO - 2015-11-23 08:10:57,087 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:10:57 INFO - 2015-11-23 08:10:57,887 INFO : Browser initialized. 08:10:57 INFO - 2015-11-23 08:10:57,887 INFO : Running cycle 1/1 for v8_7 test... 08:10:57 INFO - 2015-11-23 08:10:57,887 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpjQkNNE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:11:09 INFO - 2015-11-23 08:11:09,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 199204864 08:11:09 INFO - 2015-11-23 08:11:09,858 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 08:11:31 INFO - 2015-11-23 08:11:31,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 564789248 08:11:31 INFO - 2015-11-23 08:11:31,601 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |0;Richards;173.61111111111111 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;207.29684908789386 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |2;Encrypt;370.64492216456637 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6289.308176100629 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1126.126126126126 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |5;Earley;747.9431563201197 08:11:31 INFO - 2015-11-23 08:11:31,602 DEBUG : BROWSER_OUTPUT: |6;Boyer;13712.328767123288 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: |7;RegExp;31468.75 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: |8;Splay;679.3478260869565 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6289.308176100629 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1448295091596__endTimestamp 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:11:31 INFO - 2015-11-23 08:11:31,603 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.61 Median:173.61 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: Values: 173.6 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:207.30 Median:207.30 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: Values: 207.3 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:370.64 Median:370.64 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: Values: 370.6 08:11:31 INFO - 2015-11-23 08:11:31,604 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6289.31 Median:6289.31 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: Values: 6289.3 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1126.13 Median:1126.13 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: Values: 1126.1 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:747.94 Median:747.94 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,605 DEBUG : BROWSER_OUTPUT: Values: 747.9 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13712.33 Median:13712.33 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: Values: 13712.3 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31468.75 Median:31468.75 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: Values: 31468.8 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:679.35 Median:679.35 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: Values: 679.3 08:11:31 INFO - 2015-11-23 08:11:31,606 DEBUG : BROWSER_OUTPUT: 08:11:31 INFO - 2015-11-23 08:11:31,607 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6289.31 Median:6289.31 stddev:0.00 (0.0%) 08:11:31 INFO - 2015-11-23 08:11:31,607 DEBUG : BROWSER_OUTPUT: Values: 6289.3 08:11:31 INFO - 2015-11-23 08:11:31,607 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:11:31 INFO - 2015-11-23 08:11:31,607 DEBUG : BROWSER_OUTPUT: 08:11:32 INFO - 2015-11-23 08:11:32,277 INFO : Browser exited with error code: 0 08:11:32 INFO - 2015-11-23 08:11:32,298 INFO : Completed test v8_7 (00:00:37) 08:11:32 INFO - 2015-11-23 08:11:32,738 INFO : Completed test suite (00:20:11) 08:11:32 INFO - 2015-11-23 08:11:32,738 DEBUG : Working with test: dromaeo_css 08:11:32 INFO - 2015-11-23 08:11:32,738 DEBUG : Generating results file: dromaeo_css 08:11:32 INFO - 2015-11-23 08:11:32,739 DEBUG : Working with test: kraken 08:11:32 INFO - 2015-11-23 08:11:32,739 DEBUG : Generating results file: kraken 08:11:32 INFO - 2015-11-23 08:11:32,739 INFO : javascript benchmark 08:11:32 INFO - 2015-11-23 08:11:32,739 DEBUG : Working with test: v8_7 08:11:32 INFO - 2015-11-23 08:11:32,739 DEBUG : Generating results file: v8_7 08:11:32 INFO - 2015-11-23 08:11:32,739 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:11:32 INFO - 2015-11-23 08:11:32,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 08:11:32 INFO - 2015-11-23 08:11:32,796 DEBUG : process_Request line: dromaeo_css 6072.77 graph.html#tests=[[72,52,55]] 08:11:32 INFO - 2015-11-23 08:11:32,796 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:11:32 INFO - 2015-11-23 08:11:32,830 DEBUG : process_Request line: kraken 1646.30 graph.html#tests=[[232,52,55]] 08:11:32 INFO - 2015-11-23 08:11:32,830 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:11:32 INFO - 2015-11-23 08:11:32,855 DEBUG : process_Request line: v8_7 18550.28 graph.html#tests=[[230,52,55]] 08:11:32 INFO - 2015-11-23 08:11:32,856 INFO : javascript benchmark 08:11:32 INFO - 2015-11-23 08:11:32,858 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [324.5035096302658, 324.7772137900802, 327.9442494775888, 328.2221135907899, 334.096269590757, 9683.402238630617, 10073.395596264229, 11216.214864959446, 16147.111908845009, 16711.331546738133, 9938.204943604513, 10433.686989390311, 10649.840252396201, 10708.732281692943, 11076.335419874813, 4051.270771261172, 4163.125743593849, 4164.396162556428, 4173.749575025493, 4188.308929026707, 3311.3873933322293, 3401.404754168023, 4160.105577300879, 4287.764172970486, 4495.213337665896, 4470.932936005963, 4476.574725401098, 4501.077279157765, 4506.504284528699, 4507.143642707875, 4289.806958686867, 4434.135343607998, 4441.88895277619, 4458.910821783578, 4482.417285752831, 3769.1142581493327, 3797.2025874566098, 3812.0088776917923, 3812.2566099610585, 3842.7886466244345, 12590.874091259062, 12887.484500619965, 12938.353082345939, 12960.0, 13006.544770932973, 1719.4325872462057, 1726.7064599018197, 1750.2473936207425, 1791.1402526787215, 1831.542114471382, 8844.911550884537, 9008.234300084501, 9106.81786364269, 9151.588178531982, 9610.95194524023, 1436.9281535923267, 1445.551878917539, 1445.6602698365875, 1452.7675571908444, 1493.2906869237133, 55594.0, 57134.714326428104, 57944.42055579432, 58032.70983645055, 58066.70966645182, 6183.81448556544, 6187.628742275388, 6190.071489276645, 6293.496520278367, 6337.366263373626, 7246.166690830517, 7255.673494692752, 7297.89053164203, 7321.524100933529, 7325.816854578572, 5304.310439642822, 5373.838784836461, 5374.167004114369, 5390.595705322116, 5405.594580406485, 5690.971545142331, 5715.2855893013375, 5751.626144300607, 5786.826395208151, 5794.0, 2777.819441736321, 2792.399634078642, 2814.7044560321283, 2829.462402143586, 2830.7452329290463, 972.1590823937244, 974.5078735238659, 1032.3135115148343, 1044.8798388185303, 1074.752806854428, 388.9883303500843, 395.43452862407037, 403.4553352973462, 403.70126106680846, 411.36444193720774, 8972.910270897339, 9707.46608936501, 10277.434741089312, 10295.176385889112, 10459.163266938778, 412.16947850082107, 412.7709121437631, 417.1906501387299, 434.73263942675027, 434.9956500435018, 5584.0, 5730.684812335278, 6085.695715214221, 6090.69546522681, 6221.3156552779155, 571717.0, 596790.0, 605165.0, 608217.0, 618105.0, 67421.0, 68157.65921170362, 68454.65772671104, 68941.65529172422, 69527.3047269531, 479.4179208611568, 479.75052972454824, 481.8940531480261, 482.519892706752, 487.0842815506825, 10100.242481813746, 10158.085772280234, 10170.79658406813, 10283.84574231402, 10311.213519190851, 33591.49612755762, 33734.49398258979, 33860.49209261814, 33955.32089358248, 34346.48480272848, 45521.0, 45702.0, 46052.7697361511, 46163.76918115388, 46739.766301169635, 5885.970570147122, 5922.378150294157, 5953.76184952597, 5972.492338151305, 5993.61041532299, 10951.83572246401, 10999.175061870232, 11220.495077721685, 11241.269317494663, 11251.212415130862, 9394.107559781809, 9506.95246523763, 9615.711528654152, 9643.662471813454, 9669.951650241705, 9299.814003720023, 9320.72037838866, 9339.486328252011, 9368.016358282282, 9505.19205867509, 7886.211378862297, 8176.345892328481, 8944.0, 9298.395604285699, 9567.186789123003, 5605.5795815313195, 5747.453991870766, 5831.271091113611, 5870.031444811559, 5872.882542349214, 8996.370254082412, 9079.0, 9187.310951678784, 9423.19902808269, 9490.762730931781], "dojo.html": [2942.5586162075674, 2952.6013988111613, 2961.8963336283236, 2963.481390756617, 3071.6160479940004, 4838.250071238955, 4845.7819398127085, 4880.902381952359, 4916.016796640668, 4954.677945933517, 4855.490173531773, 4890.510948905107, 4906.141425250585, 4909.926351104737, 4931.038447502739, 4563.315502674601, 4596.149712303235, 4604.746738929358, 4628.467726211478, 4659.673822832387, 4439.356293337464, 4522.728636281817, 4556.179887620227, 4558.088382323532, 4657.580817726404, 4517.25465298227, 4538.614217791492, 4572.611328037105, 4600.953990460102, 4613.1696294666945, 4516.1193567254395, 4619.792109355087, 4635.768211589407, 4642.535746425364, 4727.3618061561765, 4497.842575509874, 4516.18708632446, 4530.569595888385, 4583.793729282191, 4598.241290187115, 4830.855074347775, 4860.489648586883, 4871.732054736988, 4897.363342765418, 5009.574186194178, 5253.816116435944, 5274.815381461631, 5290.867728306785, 5310.468953104697, 5317.229001794757, 5061.848144555669, 5071.771770270347, 5192.376914770214, 5229.607779416521, 5335.6798592084215, 4840.031993601294, 4855.562999330042, 4864.075825593126, 4893.828715994994, 4934.0, 5278.683279003272, 5313.229581710631, 5314.229436731653, 5361.705106219118, 5437.755301011464, 4883.121038213085, 4998.05037042968, 5038.244263360525, 5068.949310506921, 5149.897002059938, 5160.0, 5287.947120528823, 5317.521423071942, 5326.387465441447, 5369.087255166631, 5214.921776173361, 5230.34620672416, 5232.2413250078525, 5249.632525723239, 5270.0, 4988.376452943382, 5052.72210028452, 5153.2785410042625, 5189.299444574934, 5199.896002079937, 4081.285774989365, 4130.958690413117, 4132.5454200037975, 4143.627073563333, 4163.7293575917465, 3736.0286325555553, 3760.8683696070507, 3779.3575092234387, 3783.1677031053673, 3788.4885540452237, 4749.62003039756, 4869.415670119608, 4915.11527924977, 4922.655414120977, 4984.950150498448, 5359.973200133974, 5364.892702145935, 5376.059189641797, 5389.272448219519, 5428.321459817523, 4959.528844759742, 4996.525330093708, 5032.597392208614, 5042.168042273057, 5046.293518907356, 4459.487158976759, 4515.977420112944, 4566.634669226454, 4612.7001744886475, 4615.26155815068, 5304.496072873071, 5330.546903513245, 5349.438308977579, 5371.543418809367, 5414.0, 5272.736363181749, 5275.604329675367, 5349.144136938071, 5351.304330437174, 5388.2725832012175, 5085.364329458817, 5221.843344699665, 5229.947700522946, 5245.763940622757, 5296.3379577552805, 5172.431032586488, 5228.816991405282, 5229.372475302988, 5236.371635403776, 5260.8158714446345, 5318.0959236930585, 5333.7866485340155, 5371.140617501181, 5380.569554435558, 5395.78416863321, 4863.537963893425, 4865.221564549655, 4873.585745211697, 5032.899342013213, 5184.118699821115, 5102.540771330598, 5173.81891633791, 5179.792808287626, 5222.060029194781, 5237.135872580981, 5062.721550314768, 5109.131447653834, 5120.078385890575, 5138.306328645585, 5143.974280128576, 4951.232558953368, 5040.395152581714, 5040.798368065236, 5105.7702403391195, 5224.9738751306, 5039.067772462106, 5060.645754797129, 5066.189409694432, 5149.0474262261605, 5167.509086636764], "mootools.html": [1199.9680274963534, 1309.908306418551, 1318.3342412081897, 1406.3601061517004, 1727.6976529107403, 6687.0, 6919.515633905628, 7222.674979625923, 7381.926180738191, 7383.372413344859, 7123.608201548913, 7196.820079498015, 7243.05840240768, 7264.854702905939, 7384.187739348681, 2021.413790000898, 2026.5845501672195, 2053.938381848547, 2055.188200660738, 2059.0528356955742, 2049.8155166035053, 2072.2436310746543, 2073.6682130859067, 2099.6430606796803, 2111.7571479279927, 2025.817676409123, 2029.1173339597249, 2031.0454086579284, 2044.4377796106041, 2045.3454894433787, 2025.7467816522935, 2037.500812300981, 2055.9383218503467, 2057.5370541628163, 2059.3101311060814, 2002.5394159343432, 2027.9290224842207, 2037.327681864981, 2042.3056160905214, 2053.712480252766, 6492.935070649328, 7086.114235720535, 7221.4944953853255, 7253.673584688701, 7259.165196002475, 3999.060220848098, 4298.849540266076, 4379.233634114049, 4382.4741031076155, 4399.010222699867, 2618.8297760645687, 2639.802014848875, 2682.5976103584617, 2699.743524365182, 2727.0046433051994, 823.4565186976627, 829.1956801902145, 1369.6370461827623, 1377.6073818961547, 1446.6455718348966, 9529.666461673809, 9723.708288751348, 9757.512124393823, 9773.755656108584, 9773.804523909554, 3753.136778540896, 3760.0, 3872.8063596820048, 3874.845006199777, 3882.398228274622, 7876.803079923047, 7898.2891539761695, 7913.32736717374, 7922.603869806602, 7934.880976785353, 4422.800973956179, 4425.380446737459, 4430.180416622935, 4435.6895017349125, 4468.128714900628, 4073.1446396256524, 4089.3252613319064, 4097.344424892003, 4098.549159592442, 4100.446439730598, 3167.160702413862, 3179.60254968129, 3206.5350524174332, 3234.8059116453087, 3243.789153705002, 957.7366224288377, 958.7794807194384, 962.9566669499749, 969.1326262994721, 970.1268858027831, 1116.5310569560804, 1133.3200079951962, 1137.7155711072232, 1138.920275580718, 1178.8467499225046, 6626.436752875963, 6703.765368212089, 6715.3620406061345, 6742.595444273359, 6771.559848609824, 422.63442122564373, 423.2085999181489, 425.9105587826591, 426.413681188366, 426.4328443170576, 5141.871453213699, 5198.662086964411, 5202.7918883245, 5210.739463026834, 5229.111051121318, 8177.836443271101, 8506.617202225914, 8585.656573737106, 8620.612072456754, 8686.087960764155, 8491.235788778917, 8539.658413663385, 8659.913400866037, 8681.348898832486, 8682.6092825823, 6927.134108236471, 7001.089858318488, 7019.19279282889, 7025.859482810315, 7034.331738484836, 6828.214755303005, 6930.06444130036, 7015.508914375945, 7023.578585284899, 7038.0, 7715.922840771745, 7927.960360198393, 7969.561674107979, 7988.92011079905, 8002.599870006593, 7876.251756083163, 8056.556889370906, 8115.715949941724, 8133.877991830009, 8150.75547733569, 6278.529110316836, 6582.308857569887, 6593.670316484253, 6600.80197594073, 6626.204855417381, 7065.505414620927, 7087.964560177373, 7096.964515177391, 7107.218205997233, 7128.144622645315, 6473.741050357933, 6607.0, 6611.966940165268, 6708.530402871752, 6725.361090696376, 6532.608043517404, 6537.542372034102, 6594.769183078569, 6605.240397354366, 6618.305077966744, 6347.460465860454, 6365.077063825626, 6381.042843573501, 6389.808305750835, 6435.485161187, 5884.235049443545, 5905.675187864708, 5906.763729450774, 5912.852178695567, 5915.526757859447, 5933.2880054393745, 5980.192673988956, 5991.101334799815, 6000.21997140369, 6001.969990150022], "ext.html": [526.2711145064086, 527.7545941137371, 530.2205757536423, 537.7580088959968, 558.9659130608372, 29310.706892931063, 30385.696143038564, 36203.456948145766, 37109.62890371095, 37174.0, 39444.80277598608, 39977.60022399775, 40095.19809603806, 40121.79939100308, 40150.59849401505, 7817.491863028913, 8352.624131914079, 8493.405461617689, 8509.064002959669, 8518.361122915776, 7997.6401061952065, 10002.649907253248, 10260.179185665167, 10266.076053155215, 10279.640212592523, 10058.698239052803, 10147.594096236142, 10177.898221017806, 10179.389236645788, 10194.64318748844, 8035.517868927883, 8196.34429245659, 9799.951000245024, 10074.294799364048, 10289.485525723683, 9549.856752148653, 9650.90349096507, 9680.661176858846, 9680.95159524205, 9700.951495242549, 34728.30543389118, 35111.297774044375, 35190.64809351899, 35203.295934081434, 35346.64653353459, 2688.8386696798257, 2738.2880451082665, 2759.310172456886, 2927.9414411711646, 3121.7658675599423, 25823.0, 26015.73984260171, 26474.338141546425, 26493.739711677597, 26652.06717764869, 2121.4802373418456, 2142.817860481861, 2175.6518956966966, 2193.1775584155944, 2223.866568005925, 257394.0, 257768.0, 259828.7008564964, 260016.0, 260921.0, 53046.469535304925, 54924.17613735797, 54985.0, 55069.0, 55338.16992745112, 64187.679061604395, 65329.34670653327, 65811.67094164499, 65835.0, 66447.33552664412, 16164.838351616334, 16315.34738610466, 16335.836641633668, 16489.505314840575, 16492.25784839685, 12472.376381180904, 12480.063995200397, 12493.375331233401, 12631.368431578385, 12642.557510487273, 18092.54768630795, 18256.36102736398, 18275.817241827677, 18292.634147317247, 18333.7249941251, 7883.132855385903, 8100.311473524698, 8155.592220388957, 8170.918290817016, 8208.507489550646, 817.9468334558235, 855.3072011670566, 904.5884122724276, 905.0225756183306, 944.3861490031535, 26248.73751262501, 26278.0, 26459.603105953425, 26719.19842404731, 26742.732572674024, 971.32007594684, 982.2240430060315, 993.4238141877694, 1013.8276492996208, 1016.1565900302732, 13708.24604646754, 14052.789208161887, 14641.633959151106, 14900.850991490162, 14984.925075374771, 297702.0, 305067.0, 306758.0, 307924.0, 308694.0, 45074.09851802946, 45812.54187458083, 51938.0, 52223.0, 55678.72160639171, 1312.1012106706937, 1348.3393137362818, 1349.2444231230543, 1349.6153596225029, 1350.0414705559162, 26160.60759088653, 26183.73816261889, 26965.595516066882, 27397.31506712348, 27436.0, 41984.0, 42865.571344287404, 45712.771436142604, 46603.53396465992, 46953.765231173624, 243556.0, 243730.0, 246179.0, 246847.0, 247710.0, 28456.430871382043, 28458.0, 29083.0, 29175.562366564092, 29712.257193570334, 36477.45283820692, 37797.62202378051, 37837.43243851289, 38457.23085538218, 39689.20621587495, 31098.0, 31196.220094497818, 32347.514787277738, 32742.50886236756, 32899.0, 31530.36939261156, 32111.0, 32431.675683242865, 32460.83769581137, 33464.665353347125, 32214.692006475067, 32490.512642310856, 32824.671753282164, 32867.0, 32897.0, 27451.31371715643, 28315.292117696397, 28754.0, 28778.0, 28996.130116096552, 21852.715134779763, 22423.32730018102, 22470.775292246868, 22552.323430297118, 22573.32280031536], "prototype.html": [296.5951476234939, 307.9414911166878, 309.4522694830151, 313.78348939231915, 316.90017644442014, 5567.0, 5605.411431799658, 5645.689487078209, 5690.146478028298, 5828.562857785667, 5577.21918931349, 5593.74828132734, 5617.859553511164, 5635.3237611486575, 5636.126400407943, 4247.5964783345535, 4390.385346051556, 4394.274944634131, 4400.471943366792, 4407.955920440802, 4253.829846806124, 4279.572042795727, 4281.871543853674, 4301.462317210348, 4313.741175529462, 4218.4516012918275, 4224.176285624305, 4229.259879521087, 4266.104118135196, 4273.401723758676, 4241.321388577828, 4247.193033323674, 4247.68142389322, 4248.065425606362, 4263.126059157897, 3567.8216089195435, 3595.694365978869, 3595.856165753367, 3601.405768048269, 3612.6567976042234, 5307.946920530784, 5442.346918369821, 5492.231087647732, 5525.889482210374, 5533.280673512458, 4567.794449249792, 4682.695624784412, 4692.906141877177, 4716.080364328923, 4731.621470282369, 5602.467765562265, 5838.095095260242, 5851.093080572518, 5855.677937713424, 5877.9412205877825, 3887.611238876118, 3924.50943632046, 3964.4251583520518, 3964.643182113595, 3979.045029193002, 6021.939780602225, 6129.938700612981, 6130.908036379458, 6160.4455598995855, 6164.568480206387, 3992.5208974923194, 4017.5379831319774, 4028.879133625996, 4029.4761680981283, 4035.1727895781296, 4008.9198216036098, 4072.979635101865, 4098.344264917599, 4106.055607210358, 4111.424400583921, 4796.1127191468995, 4827.179379505493, 4832.299316599074, 4835.274708793709, 4847.297141914402, 5927.31835838884, 5929.644221346733, 5946.137810017523, 5952.285725712855, 5957.434043765836, 1423.8504956979368, 1456.978145327821, 1478.0540454109378, 1487.1300289330645, 1490.7465730825786, 925.8564922437033, 952.7237101240701, 955.9665411710557, 959.5921733263335, 973.5375696544227, 5705.429457054262, 5708.286464191976, 5715.085586306171, 5721.8569535761935, 5788.942110578924, 6156.907646385308, 6162.044883043135, 6170.382961703794, 6177.351378105234, 6200.56596038282, 5635.774569017193, 5708.1723150143, 5716.0, 5730.455606717355, 5757.251557297608, 3238.6761323867427, 3380.2056516718553, 3397.7451691123265, 3402.9829850850588, 3408.7954722716718, 6218.5647004710145, 6230.408111229426, 6249.437550620466, 6257.5932564383165, 6283.59156654816, 6322.652254126067, 6336.6831658416895, 6343.111964324999, 6391.744330226739, 6395.42441180296, 6072.21061262042, 6204.038374052029, 6219.875602487925, 6231.813045608639, 6247.9062814057825, 6121.204243448323, 6148.323684394623, 6183.350748171557, 6184.567080304516, 6222.719977600928, 5891.587588868738, 5986.2217911671205, 5995.820125396245, 6049.969750151221, 6057.818265452043, 6178.320384757583, 6225.657588832658, 6232.501399888089, 6240.656763878031, 6243.469305108935, 3881.9223615526967, 3907.9804600976813, 3912.980435097806, 3918.000909767991, 3919.3729003359326, 5748.367679555329, 6122.4795892347865, 6143.96928015357, 6187.3503282154725, 6210.3168651449205, 6023.548233882389, 6040.244969378828, 6061.39386061408, 6063.605865618721, 6087.05650624154, 6039.607425517327, 6052.213212282375, 6067.817965461043, 6073.969630151821, 6143.1706719592285, 5711.685857277889, 5800.419958004166, 5912.438318359749, 5919.171316015847, 5955.315138758925, 5991.0, 6009.819705408845, 6014.8195554133445, 6026.126211699191, 6029.909551356821, 5869.266341707286, 5881.970590147193, 5887.205227294432, 5896.115582662635, 5896.469317761251], "yui.html": [627.667336311755, 639.3382848751543, 695.4992405468063, 713.3864876206459, 732.3152852083302, 12208.877911220885, 12507.187032842881, 12521.937390313047, 12538.435770390332, 12591.181573197759, 12327.63017109486, 12396.628101156957, 12413.689657758561, 12990.0, 13384.59846204613, 662.3674390956625, 667.232682415224, 816.5468165168329, 824.7443292579289, 827.7392621324294, 802.0736049862418, 812.378530424223, 817.5585184000632, 818.758466252454, 819.1276290750361, 840.64272684109, 844.7423535821572, 846.0397448895517, 849.6389034660275, 849.9787505312355, 695.7043256615943, 700.5481464455423, 845.3110714767506, 848.868425394065, 860.3332417376521, 612.7885879371654, 616.1374076293181, 617.1329282358294, 619.6994457688018, 624.6720471752321, 12554.309512976783, 12571.811422828665, 12582.0, 12595.811062834066, 12601.810972835416, 8682.956585217096, 8797.208251257354, 8835.293176545925, 9038.86441703375, 9181.081891810833, 7988.0, 8146.266835984789, 8161.55111468869, 8485.533295668736, 8519.0, 2590.9870450647813, 2616.6205900144373, 2624.5931880558355, 2676.2907829425217, 2712.620233167358, 44381.33427998583, 44462.77768611169, 44574.77712611416, 44926.10147797026, 45069.549304506865, 6163.167972323679, 6203.906941395882, 6208.0998255253635, 6211.472024877936, 6316.747330106744, 10841.403722795165, 10875.564977400816, 10883.83674244887, 10915.890841091647, 11704.239224450383, 5538.889222215533, 5562.554995600342, 5638.718064096779, 5766.308043034863, 5855.853603659857, 3443.5523381960184, 3469.591226321037, 3562.59030211529, 3584.534010578608, 3592.191756854687, 2401.8198635102435, 2426.7451917548756, 2429.4290841652196, 2432.1487479382076, 2470.864102474345, 375.7632691404398, 376.5368596626165, 379.16394350457176, 380.0498753117207, 381.0264773503725, 435.83873966631916, 483.2919772533185, 483.9008003359303, 495.4970704734697, 524.8268071536384, 6642.0, 6729.798106056826, 6781.186257649015, 6792.184937807495, 7257.52826066304, 430.91381723655394, 440.87655456472237, 474.5373261070429, 478.32794923133054, 509.57195955397646, 3119.8833912383707, 3446.4485682291215, 3452.9482057769155, 3598.1724203433355, 3832.616738326145, 54368.18447723287, 54496.0, 54716.179257311174, 54727.0, 54896.176557351675, 46794.76602616965, 46910.06179876383, 47512.28731569029, 47549.76225118852, 48343.5165648339, 45473.09053818971, 46823.53176468192, 47392.28911566329, 47459.76270118627, 47584.5241547587, 7251.709931602677, 7297.233790451926, 7319.817004574928, 7351.191368949519, 7579.052618422697, 32860.1784955378, 33025.0, 33432.1641958953, 33704.0, 33989.0, 45291.54708453005, 45341.0, 45709.0, 45764.31353529633, 46045.76977115093, 6727.226368967631, 6843.520953533205, 6881.483888708267, 6986.091808064919, 7146.678399471933, 10253.0, 10336.534855931352, 10403.94798026005, 10547.736306592396, 11055.0603198729, 8955.0, 9206.953965230132, 9702.563384647567, 9910.058544438267, 10031.598736050477, 9939.403635781877, 9963.302568820112, 10005.099541041342, 10069.647562335284, 10086.495675216063, 9421.434713917188, 9635.325527213028, 9654.806903861743, 9679.903200968181, 9696.418214907128, 8752.912470875464, 8781.912180878366, 8838.116188381367, 8898.065703101081, 9050.0, 8321.95839020801, 8662.653493860174, 8722.171393717586, 8767.517786521803, 8943.23982461498]}, "summary": {"suite": 6072.772029712106, "subtests": {"jquery.html": {"filtered": 6200.396960404182, "value": 6200.396960404182}, "dojo.html": {"filtered": 4865.93906829265, "value": 4865.93906829265}, "mootools.html": {"filtered": 4046.3449761116112, "value": 4046.3449761116112}, "ext.html": {"filtered": 17365.554924363023, "value": 17365.554924363023}, "prototype.html": {"filtered": 4436.795761529151, "value": 4436.795761529151}, "yui.html": {"filtered": 5331.787447799943, "value": 5331.787447799943}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1448293880, "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": "20151123055225", "branch": "Mozilla-Aurora", "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 176.0, 179.0, 179.0, 175.0, 174.0, 174.0, 181.0, 180.0, 174.0], "ai-astar": [110.0, 107.0, 109.0, 109.0, 109.0, 110.0, 113.0, 118.0, 118.0, 111.0], "imaging-gaussian-blur": [131.0, 130.0, 129.0, 130.0, 136.0, 129.0, 136.0, 129.0, 128.0, 130.0], "audio-beat-detection": [165.0, 145.0, 177.0, 172.0, 144.0, 164.0, 140.0, 174.0, 164.0, 137.0], "json-stringify-tinderbox": [71.0, 71.0, 71.0, 75.0, 76.0, 75.0, 75.0, 77.0, 75.0, 75.0], "stanford-crypto-pbkdf2": [155.0, 163.0, 165.0, 164.0, 162.0, 152.0, 164.0, 165.0, 149.0, 159.0], "json-parse-financial": [57.0, 65.0, 69.0, 68.0, 71.0, 71.0, 71.0, 80.0, 64.0, 67.0], "stanford-crypto-sha256-iterative": [69.0, 73.0, 73.0, 78.0, 78.0, 77.0, 77.0, 79.0, 77.0, 77.0], "audio-fft": [79.0, 85.0, 100.0, 156.0, 78.0, 77.0, 79.0, 77.0, 126.0, 76.0], "imaging-darkroom": [140.0, 140.0, 140.0, 140.0, 140.0, 140.0, 133.0, 140.0, 141.0, 140.0], "stanford-crypto-ccm": [136.0, 135.0, 137.0, 137.0, 140.0, 146.0, 135.0, 142.0, 142.0, 141.0], "audio-oscillator": [104.0, 110.0, 151.0, 99.0, 102.0, 100.0, 142.0, 98.0, 99.0, 146.0], "stanford-crypto-aes": [83.0, 87.0, 93.0, 91.0, 91.0, 92.0, 91.0, 91.0, 93.0, 97.0], "imaging-desaturate": [113.0, 113.0, 112.0, 114.0, 113.0, 117.0, 114.0, 114.0, 113.0, 114.0]}, "summary": {"suite": 1646.2999999999997, "subtests": {"audio-fft": {"filtered": 93.3, "value": 93.3}, "stanford-crypto-pbkdf2": {"filtered": 159.8, "value": 159.8}, "audio-beat-detection": {"filtered": 158.2, "value": 158.2}, "stanford-crypto-ccm": {"filtered": 139.1, "value": 139.1}, "imaging-darkroom": {"filtered": 139.4, "value": 139.4}, "json-parse-financial": {"filtered": 68.3, "value": 68.3}, "audio-oscillator": {"filtered": 115.1, "value": 115.1}, "ai-astar": {"filtered": 111.4, "value": 111.4}, "audio-dft": {"filtered": 176.4, "value": 176.4}, "stanford-crypto-sha256-iterative": {"filtered": 75.8, "value": 75.8}, "json-stringify-tinderbox": {"filtered": 74.1, "value": 74.1}, "imaging-gaussian-blur": {"filtered": 130.8, "value": 130.8}, "stanford-crypto-aes": {"filtered": 90.9, "value": 90.9}, "imaging-desaturate": {"filtered": 113.7, "value": 113.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1448293880, "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": "20151123055225", "branch": "Mozilla-Aurora", "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [207.29684908789386], "Encrypt": [370.64492216456637], "NavierStokes": [6289.308176100629], "Decrypt": [6289.308176100629], "Splay": [679.3478260869565], "Richards": [173.61111111111111], "RegExp": [31468.75], "Earley": [747.9431563201197], "Boyer": [13712.328767123288], "RayTrace": [1126.126126126126]}, "summary": {"suite": 18550.275686092125, "subtests": {"DeltaBlue": {"filtered": 318.953232, "value": 318.953232}, "Encrypt": {"filtered": 718.1563379999998, "value": 718.1563379999998}, "NavierStokes": {"filtered": 235.95599999999985, "value": 235.95599999999985}, "Decrypt": {"filtered": 42.32277899999997, "value": 42.32277899999997}, "Splay": {"filtered": 119.95475200000003, "value": 119.95475200000003}, "RegExp": {"filtered": 28.94887785501487, "value": 28.94887785501487}, "Richards": {"filtered": 203.33952000000005, "value": 203.33952000000005}, "Earley": {"filtered": 891.0610309999998, "value": 891.0610309999998}, "Boyer": {"filtered": 48.60319580419578, "value": 48.60319580419578}, "RayTrace": {"filtered": 657.110232, "value": 657.110232}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1448293880, "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": "20151123055225", "branch": "Mozilla-Aurora", "revision": "dc1991dd52f13423e6b8ec6c73b9931284c253c8"}}] 08:11:32 INFO - RETURN: dromaeo_css: 6072.77 08:11:32 INFO - RETURN: kraken: 1646.30 08:11:32 INFO - RETURN: v8_7: 18550.28 08:11:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18550.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1646.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6072.77"}}} 08:11:32 INFO - Return code: 0 08:11:32 INFO - # TBPL SUCCESS # 08:11:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:32 INFO - 2015-11-23 08:11:32.996 screenresolution[1665:10249] starting screenresolution argv=screenresolution get 08:11:33 INFO - 2015-11-23 08:11:32.999 screenresolution[1665:10249] Display 0: 1600x1200x32@60 08:11:33 INFO - 2015-11-23 08:11:33.005 screenresolution[1666:10253] starting screenresolution argv=screenresolution list 08:11:33 INFO - Available Modes on Display 0 08:11:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:33 INFO - Intel HD Graphics 3000: 08:11:33 INFO - Chipset Model: Intel HD Graphics 3000 08:11:33 INFO - Type: GPU 08:11:33 INFO - Bus: Built-In 08:11:33 INFO - VRAM (Total): 512 MB 08:11:33 INFO - VRAM (Dynamic, Max): 10 08:11:33 INFO - Vendor: Intel (0x8086) 08:11:33 INFO - Device ID: 0x0116 08:11:33 INFO - Revision ID: 0x0009 08:11:33 INFO - Displays: 08:11:33 INFO - Display: 08:11:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:33 INFO - Display Serial Number: 1600x1200 60 08:11:33 INFO - Main Display: Yes 08:11:33 INFO - Mirror: Off 08:11:33 INFO - Online: Yes 08:11:33 INFO - Rotation: Supported 08:11:33 INFO - Return code: 0 08:11:33 INFO - Running post-action listener: _resource_record_post_action 08:11:33 INFO - Running post-run listener: _resource_record_post_run 08:11:34 INFO - Total resource usage - Wall time: 1252s; CPU: 30.0%; Read bytes: 40735744; Write bytes: 687240192; Read time: 5008; Write time: 47854 08:11:34 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 342374912; Write bytes: 344342528; Read time: 35152; Write time: 4607 08:11:34 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 38581248; Write bytes: 341582848; Read time: 4137; Write time: 43217 08:11:34 INFO - Running post-run listener: _upload_blobber_files 08:11:34 INFO - Blob upload gear active. 08:11:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:11:34 INFO - Copying logs to upload dir... 08:11:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1368.034006 ========= master_lag: 3.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2015-11-23 08:11:38.042191) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 08:11:38.047733) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010171 build_url: 'https://queue.taskcluster.net/v1/task/ROwIRy7zRwKSkz_RZ6zXtg/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 2.16 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 08:11:40.213454) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 08:11:40.213799) ========= 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.qVYMLZk88i/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.DKPxF37mOC/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.005140 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 08:11:40.251939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 08:11:40.252233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 08:11:40.262000) ========= ========= Total master_lag: 6.54 =========