builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0007 starttime: 1447113567.34 results: success (0) buildid: 20151109141834 builduid: 6af27f72427c49a4b1b15831e06f01ec revision: 76ad230fa6ef4aac32718702aea593ef55976582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:27.340644) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:27.341085) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-09 15:59:27.341380) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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.005767 basedir: '/builds/slave/test' ========= master_lag: 3.74 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-09 15:59:31.091007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.091353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.182691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.183057) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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.062613 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.275263) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.275590) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.275974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.276262) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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-09 15:59:31-- 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% 15.4M=0.001s 2015-11-09 15:59:31 (15.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.259603 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.882885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:31.883243) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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.218000 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:32.203663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 15:59:32.204021) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 76ad230fa6ef4aac32718702aea593ef55976582 --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 76ad230fa6ef4aac32718702aea593ef55976582 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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-09 15:59:32,290 truncating revision to first 12 chars 2015-11-09 15:59:32,290 Setting DEBUG logging. 2015-11-09 15:59:32,290 attempt 1/10 2015-11-09 15:59:32,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/76ad230fa6ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 15:59:33,304 unpacking tar archive at: mozilla-aurora-76ad230fa6ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-09 15:59:33.687883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:33.688285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:33.728002) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:33.728412) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 15:59:33.728895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-09 15:59:33.729184) ========= /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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 15:59:34 INFO - MultiFileLogger online at 20151109 15:59:34 in /builds/slave/test 15:59:34 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 15:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:59:34 INFO - {'append_to_log': False, 15:59:34 INFO - 'base_work_dir': '/builds/slave/test', 15:59:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:59:34 INFO - 'branch': 'Mozilla-Aurora', 15:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:34 INFO - 'config_files': ('talos/mac_config.py',), 15:59:34 INFO - 'default_actions': ('clobber', 15:59:34 INFO - 'read-buildbot-config', 15:59:34 INFO - 'download-and-extract', 15:59:34 INFO - 'populate-webroot', 15:59:34 INFO - 'create-virtualenv', 15:59:34 INFO - 'install', 15:59:34 INFO - 'run-tests'), 15:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:34 INFO - 'download_minidump_stackwalk': True, 15:59:34 INFO - 'download_symbols': 'ondemand', 15:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:34 INFO - 'installer_path': 'installer.exe', 15:59:34 INFO - 'log_level': 'info', 15:59:34 INFO - 'log_name': 'talos', 15:59:34 INFO - 'log_to_console': True, 15:59:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:59:34 INFO - 'opt_config_files': (), 15:59:34 INFO - 'pip_index': False, 15:59:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:34 INFO - 'cmd': ('bash', 15:59:34 INFO - '-c', 15:59:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:34 INFO - 'enabled': True, 15:59:34 INFO - 'halt_on_failure': False, 15:59:34 INFO - 'name': 'check_screen_resolution'},), 15:59:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:59:34 INFO - 'cmd': ('bash', 15:59:34 INFO - '-c', 15:59:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:59:34 INFO - 'enabled': True, 15:59:34 INFO - 'halt_on_failure': False, 15:59:34 INFO - 'name': 'check_screen_resolution'},), 15:59:34 INFO - 'run_cmd_checks_enabled': True, 15:59:34 INFO - 'sps_profile': False, 15:59:34 INFO - 'sps_profile_interval': 0, 15:59:34 INFO - 'suite': 'dromaeojs', 15:59:34 INFO - 'system_bits': '64', 15:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:34 INFO - 'title': 't-yosemite-r5-0007', 15:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:34 INFO - 'use_talos_json': True, 15:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:34 INFO - 'work_dir': 'build'} 15:59:34 INFO - ##### 15:59:34 INFO - ##### Running clobber step. 15:59:34 INFO - ##### 15:59:34 INFO - Running pre-action listener: _resource_record_pre_action 15:59:34 INFO - Running main action method: clobber 15:59:34 INFO - rmtree: /builds/slave/test/build 15:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:59:39 INFO - Running post-action listener: _resource_record_post_action 15:59:39 INFO - ##### 15:59:39 INFO - ##### Running read-buildbot-config step. 15:59:39 INFO - ##### 15:59:39 INFO - Running pre-action listener: _resource_record_pre_action 15:59:39 INFO - Running main action method: read_buildbot_config 15:59:39 INFO - Using buildbot properties: 15:59:39 INFO - { 15:59:39 INFO - "properties": { 15:59:39 INFO - "buildnumber": 409, 15:59:39 INFO - "product": "firefox", 15:59:39 INFO - "script_repo_revision": "production", 15:59:39 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 15:59:39 INFO - "repository": "", 15:59:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 15:59:39 INFO - "buildid": "20151109141834", 15:59:39 INFO - "slavename": "t-yosemite-r5-0007", 15:59:39 INFO - "pgo_build": "False", 15:59:39 INFO - "basedir": "/builds/slave/test", 15:59:39 INFO - "project": "", 15:59:39 INFO - "platform": "yosemite", 15:59:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:59:39 INFO - "slavebuilddir": "test", 15:59:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:59:39 INFO - "branch": "mozilla-aurora", 15:59:39 INFO - "repo_path": "releases/mozilla-aurora", 15:59:39 INFO - "stage_platform": "macosx64", 15:59:39 INFO - "builduid": "6af27f72427c49a4b1b15831e06f01ec", 15:59:39 INFO - "revision": "76ad230fa6ef4aac32718702aea593ef55976582" 15:59:39 INFO - }, 15:59:39 INFO - "sourcestamp": { 15:59:39 INFO - "repository": "", 15:59:39 INFO - "hasPatch": false, 15:59:39 INFO - "project": "", 15:59:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:59:39 INFO - "changes": [ 15:59:39 INFO - { 15:59:39 INFO - "category": null, 15:59:39 INFO - "files": [ 15:59:39 INFO - { 15:59:39 INFO - "url": null, 15:59:39 INFO - "name": "https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 15:59:39 INFO - } 15:59:39 INFO - ], 15:59:39 INFO - "repository": "", 15:59:39 INFO - "rev": "76ad230fa6ef4aac32718702aea593ef55976582", 15:59:39 INFO - "who": "kwierso@gmail.com", 15:59:39 INFO - "when": 1447113556, 15:59:39 INFO - "number": 6639629, 15:59:39 INFO - "comments": "Bug 1215140 P10 Avoid AddRef'ing the nsIChannel OMT. r=bz a=ritu l10n=ritu", 15:59:39 INFO - "project": "", 15:59:39 INFO - "at": "Mon 09 Nov 2015 15:59:16", 15:59:39 INFO - "branch": "mozilla-aurora-macosx64-talos", 15:59:39 INFO - "revlink": "", 15:59:39 INFO - "properties": [ 15:59:39 INFO - [ 15:59:39 INFO - "buildid", 15:59:39 INFO - "20151109141834", 15:59:39 INFO - "Change" 15:59:39 INFO - ], 15:59:39 INFO - [ 15:59:39 INFO - "builduid", 15:59:39 INFO - "6af27f72427c49a4b1b15831e06f01ec", 15:59:39 INFO - "Change" 15:59:39 INFO - ], 15:59:39 INFO - [ 15:59:39 INFO - "pgo_build", 15:59:39 INFO - "False", 15:59:39 INFO - "Change" 15:59:39 INFO - ] 15:59:39 INFO - ], 15:59:39 INFO - "revision": "76ad230fa6ef4aac32718702aea593ef55976582" 15:59:39 INFO - } 15:59:39 INFO - ], 15:59:39 INFO - "revision": "76ad230fa6ef4aac32718702aea593ef55976582" 15:59:39 INFO - } 15:59:39 INFO - } 15:59:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 15:59:39 INFO - Running post-action listener: _resource_record_post_action 15:59:39 INFO - ##### 15:59:39 INFO - ##### Running download-and-extract step. 15:59:39 INFO - ##### 15:59:39 INFO - Running pre-action listener: _resource_record_pre_action 15:59:39 INFO - Running main action method: download_and_extract 15:59:39 INFO - mkdir: /builds/slave/test/build/tests 15:59:39 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')]} 15:59:39 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/test_packages.json 15:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/test_packages.json 15:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:59:44 INFO - Downloaded 1149 bytes. 15:59:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:59:44 INFO - Using the following test package requirements: 15:59:44 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:59:44 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 15:59:44 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'jsshell-mac.zip'], 15:59:44 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 15:59:44 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:59:44 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 15:59:44 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 15:59:44 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 15:59:44 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 15:59:44 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 15:59:44 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 15:59:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:59:44 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')]} 15:59:44 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 15:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 15:59:47 INFO - Downloaded 17445865 bytes. 15:59:47 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 15:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 15:59:53 INFO - Return code: 0 15:59:53 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 15:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:53 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 15:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 15:59:59 INFO - Downloaded 17445865 bytes. 15:59: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 15:59:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 15:59:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 16:00:05 INFO - Return code: 0 16:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:05 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 16:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 16:00:06 INFO - Downloaded 11131307 bytes. 16:00:06 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 16:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 16:00:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:00:06 INFO - Return code: 0 16:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:06 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:00:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:00:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:00:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 16:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 16:00:10 INFO - Downloaded 107686908 bytes. 16:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:00:10 INFO - mkdir: /builds/slave/test/properties 16:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:00:10 INFO - Contents: 16:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 16:00:10 INFO - Running post-action listener: _resource_record_post_action 16:00:10 INFO - Running post-action listener: set_extra_try_arguments 16:00:10 INFO - ##### 16:00:10 INFO - ##### Running populate-webroot step. 16:00:10 INFO - ##### 16:00:10 INFO - Running pre-action listener: _resource_record_pre_action 16:00:10 INFO - Running main action method: populate_webroot 16:00:10 INFO - Guessing talos json url... 16:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:10 INFO - https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 16:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 16:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 16:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 16:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/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 16:00:11 INFO - Downloaded 107 bytes. 16:00:11 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 16:00:11 INFO - Contents: 16:00:11 INFO - 20151109141834 16:00:11 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/76ad230fa6ef4aac32718702aea593ef55976582 16:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:11 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/76ad230fa6/testing/talos/talos.json 16:00:11 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/76ad230fa6/testing/talos/talos.json to /builds/slave/test/build/talos.json 16:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/76ad230fa6/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 16:00:11 INFO - Downloaded 4264 bytes. 16:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:00:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:00:11 INFO - '../fennec_ids.txt'], 16:00:11 INFO - 'tests': ['tcheck2']}, 16:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:00:11 INFO - '--tppagecycles', 16:00:11 INFO - '7'], 16:00:11 INFO - 'tests': ['tsvgm']}}, 16:00:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:00:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:00:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:00:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'tests': ['damp', 'tps']}, 16:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['damp', 'tps']}, 16:00:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:00:11 INFO - 'other': {'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'other_l64': {'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'other_nol64': {'tests': ['a11yr', 16:00:11 INFO - 'ts_paint', 16:00:11 INFO - 'tpaint', 16:00:11 INFO - 'sessionrestore', 16:00:11 INFO - 'sessionrestore_no_auto_restore']}, 16:00:11 INFO - 'svgr': {'tests': ['tsvgx', 16:00:11 INFO - 'tsvgr_opacity', 16:00:11 INFO - 'tart', 16:00:11 INFO - 'tscrollx', 16:00:11 INFO - 'cart']}, 16:00:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['tsvgx', 16:00:11 INFO - 'tsvgr_opacity', 16:00:11 INFO - 'tart', 16:00:11 INFO - 'tscrollx', 16:00:11 INFO - 'cart']}, 16:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'tests': ['tp5o']}, 16:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'talos_options': ['--e10s'], 16:00:11 INFO - 'tests': ['tp5o']}, 16:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'talos_options': ['--xperf_path', 16:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:00:11 INFO - 'tests': ['tp5n']}, 16:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:00:11 INFO - 'talos_options': ['--e10s', 16:00:11 INFO - '--xperf_path', 16:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 16:00:11 INFO - 'C:/slave/talos-data/talos/xperf.config'], 16:00:11 INFO - 'tests': ['tp5n']}}, 16:00:11 INFO - 'talos.zip': {'path': '', 16:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:00:11 INFO - Running post-action listener: _resource_record_post_action 16:00:11 INFO - ##### 16:00:11 INFO - ##### Running create-virtualenv step. 16:00:11 INFO - ##### 16:00:11 INFO - Running pre-action listener: _resource_record_pre_action 16:00:11 INFO - Running main action method: create_virtualenv 16:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:00:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:00:11 INFO - Using real prefix '/tools/python27' 16:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:00:16 INFO - Installing pip.................done. 16:00:16 INFO - Return code: 0 16:00:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:00: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')]} 16:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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')]} 16:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00: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', 'pip>=1.5'] in /builds/slave/test/build 16:00: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 pip>=1.5 16:00:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:16 INFO - 'HOME': '/Users/cltbld', 16:00:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:16 INFO - 'LOGNAME': 'cltbld', 16:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:16 INFO - 'MOZ_NO_REMOTE': '1', 16:00:16 INFO - 'NO_EM_RESTART': '1', 16:00:16 INFO - 'PAGER': '/bin/cat', 16:00:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:16 INFO - 'PWD': '/builds/slave/test', 16:00:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:16 INFO - 'SHELL': '/bin/bash', 16:00:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:16 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:16 INFO - 'USER': 'cltbld', 16:00:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:16 INFO - 'XPC_FLAGS': '0x0', 16:00:16 INFO - 'XPC_SERVICE_NAME': '0', 16:00:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:00:17 INFO - Cleaning up... 16:00:17 INFO - Return code: 0 16:00:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:17 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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:17 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 16:00:17 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 16:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:17 INFO - 'HOME': '/Users/cltbld', 16:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:17 INFO - 'LOGNAME': 'cltbld', 16:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:17 INFO - 'MOZ_NO_REMOTE': '1', 16:00:17 INFO - 'NO_EM_RESTART': '1', 16:00:17 INFO - 'PAGER': '/bin/cat', 16:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:17 INFO - 'PWD': '/builds/slave/test', 16:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:17 INFO - 'SHELL': '/bin/bash', 16:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:17 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:17 INFO - 'USER': 'cltbld', 16:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:17 INFO - 'XPC_FLAGS': '0x0', 16:00:17 INFO - 'XPC_SERVICE_NAME': '0', 16:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:17 INFO - Downloading/unpacking psutil>=0.7.1 16:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:00:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:19 INFO - Installing collected packages: psutil 16:00:19 INFO - Running setup.py install for psutil 16:00:20 INFO - building 'psutil._psutil_osx' extension 16:00: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:00:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:00:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:00:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:00:23 INFO - building 'psutil._psutil_posix' extension 16:00:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:00:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:00:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:00:23 INFO - ^ 16:00:23 INFO - 1 warning generated. 16:00:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:00:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:00:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:00:23 INFO - Successfully installed psutil 16:00:23 INFO - Cleaning up... 16:00:23 INFO - Return code: 0 16:00:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:23 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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:23 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 16:00:23 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 16:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:23 INFO - 'HOME': '/Users/cltbld', 16:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:23 INFO - 'LOGNAME': 'cltbld', 16:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:23 INFO - 'MOZ_NO_REMOTE': '1', 16:00:23 INFO - 'NO_EM_RESTART': '1', 16:00:23 INFO - 'PAGER': '/bin/cat', 16:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:23 INFO - 'PWD': '/builds/slave/test', 16:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:23 INFO - 'SHELL': '/bin/bash', 16:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:23 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:23 INFO - 'USER': 'cltbld', 16:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:23 INFO - 'XPC_FLAGS': '0x0', 16:00:23 INFO - 'XPC_SERVICE_NAME': '0', 16:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:00:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:00:26 INFO - Installing collected packages: mozsystemmonitor 16:00:26 INFO - Running setup.py install for mozsystemmonitor 16:00:26 INFO - Successfully installed mozsystemmonitor 16:00:26 INFO - Cleaning up... 16:00:26 INFO - Return code: 0 16:00:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:26 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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:26 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 16:00:26 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 16:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:26 INFO - 'HOME': '/Users/cltbld', 16:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:26 INFO - 'LOGNAME': 'cltbld', 16:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:26 INFO - 'MOZ_NO_REMOTE': '1', 16:00:26 INFO - 'NO_EM_RESTART': '1', 16:00:26 INFO - 'PAGER': '/bin/cat', 16:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:26 INFO - 'PWD': '/builds/slave/test', 16:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:26 INFO - 'SHELL': '/bin/bash', 16:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:26 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:26 INFO - 'USER': 'cltbld', 16:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:26 INFO - 'XPC_FLAGS': '0x0', 16:00:26 INFO - 'XPC_SERVICE_NAME': '0', 16:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:29 INFO - Downloading blobuploader-1.2.4.tar.gz 16:00:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:00:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:00:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:30 INFO - Downloading docopt-0.6.1.tar.gz 16:00:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:00:30 INFO - Installing collected packages: blobuploader, requests, docopt 16:00:30 INFO - Running setup.py install for blobuploader 16:00:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:00:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:00:30 INFO - Running setup.py install for requests 16:00:31 INFO - Running setup.py install for docopt 16:00:31 INFO - Successfully installed blobuploader requests docopt 16:00:31 INFO - Cleaning up... 16:00:31 INFO - Return code: 0 16:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:31 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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:31 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 16:00:31 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 16:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:31 INFO - 'HOME': '/Users/cltbld', 16:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:31 INFO - 'LOGNAME': 'cltbld', 16:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:31 INFO - 'MOZ_NO_REMOTE': '1', 16:00:31 INFO - 'NO_EM_RESTART': '1', 16:00:31 INFO - 'PAGER': '/bin/cat', 16:00:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:31 INFO - 'PWD': '/builds/slave/test', 16:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:31 INFO - 'SHELL': '/bin/bash', 16:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:31 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:31 INFO - 'USER': 'cltbld', 16:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:31 INFO - 'XPC_FLAGS': '0x0', 16:00:31 INFO - 'XPC_SERVICE_NAME': '0', 16:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-e2Dnzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-YCmQeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-CHuqvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-X22lOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-UU1QYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-xr_yMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-PqnVKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-JSxvQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:00:32 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-dfl0Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-yhqMU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-pHr5QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-aZm1QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-cqXZQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-Co4gri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-7Ihu_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-6XXDvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:00:33 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-Pn4Ov0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:00:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:00:34 INFO - Running setup.py install for manifestparser 16:00:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:00:34 INFO - Running setup.py install for mozcrash 16:00:34 INFO - Running setup.py install for mozdebug 16:00:34 INFO - Running setup.py install for mozdevice 16:00:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:00:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:00:34 INFO - Running setup.py install for mozfile 16:00:34 INFO - Running setup.py install for mozhttpd 16:00:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for mozinfo 16:00:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for mozInstall 16:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for mozleak 16:00:35 INFO - Running setup.py install for mozlog 16:00:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for moznetwork 16:00:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:00:35 INFO - Running setup.py install for mozprocess 16:00:36 INFO - Running setup.py install for mozprofile 16:00:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozrunner 16:00:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Running setup.py install for mozscreenshot 16:00:36 INFO - Running setup.py install for moztest 16:00:36 INFO - Running setup.py install for mozversion 16:00:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:36 INFO - Cleaning up... 16:00:36 INFO - Return code: 0 16:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:36 INFO - 'HOME': '/Users/cltbld', 16:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:36 INFO - 'LOGNAME': 'cltbld', 16:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:36 INFO - 'MOZ_NO_REMOTE': '1', 16:00:36 INFO - 'NO_EM_RESTART': '1', 16:00:36 INFO - 'PAGER': '/bin/cat', 16:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:36 INFO - 'PWD': '/builds/slave/test', 16:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:36 INFO - 'SHELL': '/bin/bash', 16:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:36 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:36 INFO - 'USER': 'cltbld', 16:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:36 INFO - 'XPC_FLAGS': '0x0', 16:00:36 INFO - 'XPC_SERVICE_NAME': '0', 16:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-deyctp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-3e5yiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:00:37 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)) 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-O9THIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-9szptt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:00:37 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)) 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-om89lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:00:37 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-S1upMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-GEP2GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-gMRqrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-uwf3Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-1olt6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-SIyy3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-ENcws2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-wxhoKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:00:38 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)) 16:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:00:38 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-yHlOZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:39 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-aP_Ulp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:00:39 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-Wf6GF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:00:39 INFO - Running setup.py (path:/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/pip-OnZVg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:00:39 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)) 16:00:39 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)) 16:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:00:39 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)) 16:00:39 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)) 16:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:41 INFO - Downloading blessings-1.5.1.tar.gz 16:00:41 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 16:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:41 INFO - Installing collected packages: blessings 16:00:41 INFO - Running setup.py install for blessings 16:00:42 INFO - Successfully installed blessings 16:00:42 INFO - Cleaning up... 16:00:42 INFO - Return code: 0 16:00:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:42 INFO - Reading from file tmpfile_stdout 16:00:42 INFO - Current package versions: 16:00:42 INFO - blessings == 1.5.1 16:00:42 INFO - blobuploader == 1.2.4 16:00:42 INFO - docopt == 0.6.1 16:00:42 INFO - manifestparser == 1.1 16:00:42 INFO - mozInstall == 1.12 16:00:42 INFO - mozcrash == 0.16 16:00:42 INFO - mozdebug == 0.1 16:00:42 INFO - mozdevice == 0.46 16:00:42 INFO - mozfile == 1.2 16:00:42 INFO - mozhttpd == 0.7 16:00:42 INFO - mozinfo == 0.8 16:00:42 INFO - mozleak == 0.1 16:00:42 INFO - mozlog == 3.0 16:00:42 INFO - moznetwork == 0.27 16:00:42 INFO - mozprocess == 0.22 16:00:42 INFO - mozprofile == 0.27 16:00:42 INFO - mozrunner == 6.11 16:00:42 INFO - mozscreenshot == 0.1 16:00:42 INFO - mozsystemmonitor == 0.0 16:00:42 INFO - moztest == 0.7 16:00:42 INFO - mozversion == 1.4 16:00:42 INFO - psutil == 3.1.1 16:00:42 INFO - requests == 1.2.3 16:00:42 INFO - wsgiref == 0.1.2 16:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:42 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 0x10c53fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef02702b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, '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.P8CjZV0DLt/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.PLUO4QDEft/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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 16:00:42 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 16:00:42 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 16:00:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:42 INFO - 'HOME': '/Users/cltbld', 16:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:42 INFO - 'LOGNAME': 'cltbld', 16:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:42 INFO - 'MOZ_NO_REMOTE': '1', 16:00:42 INFO - 'NO_EM_RESTART': '1', 16:00:42 INFO - 'PAGER': '/bin/cat', 16:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:42 INFO - 'PWD': '/builds/slave/test', 16:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:42 INFO - 'SHELL': '/bin/bash', 16:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:00:42 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:42 INFO - 'USER': 'cltbld', 16:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:42 INFO - 'XPC_FLAGS': '0x0', 16:00:42 INFO - 'XPC_SERVICE_NAME': '0', 16:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 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)) 16:00:42 INFO - Cleaning up... 16:00:42 INFO - Return code: 0 16:00:42 INFO - Running post-action listener: _resource_record_post_action 16:00:42 INFO - Running post-action listener: _start_resource_monitoring 16:00:42 INFO - Starting resource monitoring. 16:00:42 INFO - ##### 16:00:42 INFO - ##### Running install step. 16:00:42 INFO - ##### 16:00:42 INFO - Running pre-action listener: _resource_record_pre_action 16:00:42 INFO - Running main action method: install 16:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:00:43 INFO - Reading from file tmpfile_stdout 16:00:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:00:43 INFO - Reading from file tmpfile_stdout 16:00:43 INFO - Output received: 16:00:43 INFO - Usage: mozinstall [options] installer 16:00:43 INFO - Options: 16:00:43 INFO - -h, --help show this help message and exit 16:00:43 INFO - -d DEST, --destination=DEST 16:00:43 INFO - Directory to install application into. [default: 16:00:43 INFO - "/builds/slave/test"] 16:00:43 INFO - --app=APP Application being installed. [default: firefox] 16:00:43 INFO - mkdir: /builds/slave/test/build/application 16:00:43 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'] 16:00:43 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 16:01:20 INFO - Reading from file tmpfile_stdout 16:01:20 INFO - Output received: 16:01:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:01:20 INFO - Running post-action listener: _resource_record_post_action 16:01:20 INFO - ##### 16:01:20 INFO - ##### Running run-tests step. 16:01:20 INFO - ##### 16:01:20 INFO - Running pre-action listener: _resource_record_pre_action 16:01:20 INFO - Running main action method: run_tests 16:01:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:01:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:01:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:01:20 INFO - 2015-11-09 16:01:20.789 screenresolution[1636:8053] starting screenresolution argv=screenresolution get 16:01:20 INFO - 2015-11-09 16:01:20.793 screenresolution[1636:8053] Display 0: 1600x1200x32@60 16:01:20 INFO - 2015-11-09 16:01:20.799 screenresolution[1637:8055] starting screenresolution argv=screenresolution list 16:01:20 INFO - Available Modes on Display 0 16:01:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:01:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:01:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:01:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:01:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:01:21 INFO - Intel HD Graphics 3000: 16:01:21 INFO - Chipset Model: Intel HD Graphics 3000 16:01:21 INFO - Type: GPU 16:01:21 INFO - Bus: Built-In 16:01:21 INFO - VRAM (Total): 512 MB 16:01:21 INFO - VRAM (Dynamic, Max): 10 16:01:21 INFO - Vendor: Intel (0x8086) 16:01:21 INFO - Device ID: 0x0116 16:01:21 INFO - Revision ID: 0x0009 16:01:21 INFO - Displays: 16:01:21 INFO - Display: 16:01:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:01:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:01:21 INFO - Display Serial Number: 1600x1200 60 16:01:21 INFO - Main Display: Yes 16:01:21 INFO - Mirror: Off 16:01:21 INFO - Online: Yes 16:01:21 INFO - Rotation: Supported 16:01:21 INFO - Return code: 0 16:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:01:21 INFO - Python 2.7.3 16:01:21 INFO - Return code: 0 16:01:21 INFO - grabbing minidump binary from tooltool 16:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:01:21 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 0x10c4f49f0>, '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 0x10c253cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c4be990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:01:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:01:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:01:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:01:21 INFO - Return code: 0 16:01:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:01:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:01:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:01:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:01:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:01:21 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/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0007', '--webServer', 'localhost'] in /builds/slave/test/build 16:01:21 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/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0007 --webServer localhost 16:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P8CjZV0DLt/Render', 16:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:01:21 INFO - 'HOME': '/Users/cltbld', 16:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:01:21 INFO - 'LOGNAME': 'cltbld', 16:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:21 INFO - 'MOZ_NO_REMOTE': '1', 16:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:21 INFO - 'NO_EM_RESTART': '1', 16:01:21 INFO - 'PAGER': '/bin/cat', 16:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:21 INFO - 'PWD': '/builds/slave/test', 16:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:01:21 INFO - 'SHELL': '/bin/bash', 16:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PLUO4QDEft/Listeners', 16:01:21 INFO - 'TMPDIR': '/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/', 16:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:01:21 INFO - 'USER': 'cltbld', 16:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:21 INFO - 'XPC_FLAGS': '0x0', 16:01:21 INFO - 'XPC_SERVICE_NAME': '0', 16:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:01:21 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/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0007', '--webServer', 'localhost'] with output_timeout 3600 16:01:21 INFO - mozversion INFO | application_buildid: 20151109141834 16:01:21 INFO - mozversion INFO | application_changeset: 76ad230fa6ef4aac32718702aea593ef55976582 16:01:21 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:01:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:01:21 INFO - mozversion INFO | application_name: Firefox 16:01:21 INFO - mozversion INFO | application_remotingname: firefox-dev 16:01:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:21 INFO - mozversion INFO | application_vendor: Mozilla 16:01:21 INFO - mozversion INFO | application_version: 44.0a2 16:01:21 INFO - mozversion INFO | platform_buildid: 20151109141834 16:01:21 INFO - mozversion INFO | platform_changeset: 76ad230fa6ef4aac32718702aea593ef55976582 16:01:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:01:21 INFO - mozversion INFO | platform_version: 44.0a2 16:01:21 INFO - 2015-11-09 16:01:21,631 DEBUG : using testdate: 1447113681 16:01:21 INFO - 2015-11-09 16:01:21,631 DEBUG : actual date: 1447113681 16:01:21 INFO - 2015-11-09 16:01:21,644 INFO : starting webserver on 'localhost:49270' 16:01:21 INFO - 2015-11-09 16:01:21,645 INFO : Starting test suite t-yosemite-r5-0007 16:01:21 INFO - 2015-11-09 16:01:21,645 INFO : Starting test dromaeo_css 16:01:21 INFO - 2015-11-09 16:01:21,645 DEBUG : operating with platform_type : mac_ 16:01:21 INFO - 2015-11-09 16:01:21,646 INFO : Initialising browser for dromaeo_css test... 16:01:21 INFO - 2015-11-09 16:01:21,662 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpIPkdXH/profile http://localhost:49270/getInfo.html 16:01:24 INFO - 2015-11-09 16:01:24,778 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:01:24 INFO - 2015-11-09 16:01:24,778 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:01:24 INFO - 2015-11-09 16:01:24,778 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:01:24 INFO - 2015-11-09 16:01:24,778 DEBUG : BROWSER_OUTPUT: __metrics 16:01:24 INFO - 2015-11-09 16:01:24,794 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:01:25 INFO - 2015-11-09 16:01:25,513 INFO : Browser initialized. 16:01:25 INFO - 2015-11-09 16:01:25,514 INFO : Running cycle 1/1 for dromaeo_css test... 16:01:25 INFO - 2015-11-09 16:01:25,514 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpIPkdXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:01:37 INFO - 2015-11-09 16:01:37,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 203341824 16:01:37 INFO - 2015-11-09 16:01:37,372 DEBUG : BROWSER_OUTPUT: 16:02:28 INFO - 2015-11-09 16:02:28,990 DEBUG : BROWSER_OUTPUT: 1447113748987 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:04:39 INFO - 2015-11-09 16:04:39,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 16:04:40 INFO - 2015-11-09 16:04:40,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 305774592 16:04:40 INFO - 2015-11-09 16:04:40,394 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-09 16:07:42,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 16:07:43 INFO - 2015-11-09 16:07:43,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 342745088 16:07:43 INFO - 2015-11-09 16:07:43,444 DEBUG : BROWSER_OUTPUT: 16:10:45 INFO - 2015-11-09 16:10:45,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 16:10:45 INFO - 2015-11-09 16:10:45,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 309104640 16:10:45 INFO - 2015-11-09 16:10:45,963 DEBUG : BROWSER_OUTPUT: 16:13:47 INFO - 2015-11-09 16:13:47,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 16:13:48 INFO - 2015-11-09 16:13:48,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 300593152 16:13:48 INFO - 2015-11-09 16:13:48,371 DEBUG : BROWSER_OUTPUT: 16:16:51 INFO - 2015-11-09 16:16:51,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 16:16:51 INFO - 2015-11-09 16:16:51,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 298708992 16:16:51 INFO - 2015-11-09 16:16:51,863 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 16:19:54 INFO - 2015-11-09 16:19:54,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 342614016 16:19:54 INFO - 2015-11-09 16:19:54,750 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,750 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:19:54 INFO - 2015-11-09 16:19:54,750 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:19:54 INFO - 2015-11-09 16:19:54,750 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:19:54 INFO - 2015-11-09 16:19:54,750 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:19:54 INFO - 2015-11-09 16:19:54,751 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3218.4528630132877;3320.9833950830243;3323.6842499962495;3338.699517043467;3348.012336360773;5535.14205298179;5642.322921249456;5659.462351076651;5664.518515926146;5685.118806584986;5592.4407559244055;5619.943800561993;5627.380988091307;5636;5636.915446268309;5132.615053870956;5184.300119483869;5219.19102539107;5219.295395121667;5306.416294207634;5186.636935414523;5241.18761591952;5319.787208511655;5320.308359913206;5384.623076384654;5247.895042099156;5296.470352964711;5296.973515132419;5314.3091398118195;5321.4412486688925;5256.816011439581;5266.815661451869;5328.440513746078;5343.572514198855;5365.490278423544;5086.745662716887;5142.588592912558;5159.613029022838;5192.247124167013;5239.711815850127;5576.581756368248;5604.8318550443555;5651.06757385031;5681.801136960228;5697.800576979786;5797.739101740432;6047.879042419127;6051.152838602599;6075.453209211148;6098.60359076663;5951.6726580038085;5970.253718285215;6011.549133814981;6018.548608854353;6057.212562366864;5599.860003499904;5602.663840169603;5614.606977511617;5628.437156284339;5704.686242256675;6016.69916504173;6060.939390606126;6087.391260873877;6149.0776383542825;6154.7230374633245;5775.422457754275;5837.941620583825;5838.97817881869;5879.3826648202175;5912.054071348563;6085.6348619083;6099.115628233882;6149;6153.784617538365;6175.320714721377;5617.269754931915;5658.179563963202;5707.942920570824;6007.579469437185;6034.48706859913;5915.349311575723;6031.487323577458;6034.547408944347;6035.275766907999;6059.36376680451;4722.268048452495;4724.811007559659;4732.337472753748;4771.141194584939;4795.856124316276;4062.8171732272117;4113.01287690952;4237.6821738369745;4241.6606671466825;4292.5063617683745;5645.661260324311;5656.604037717402;5707.885842283131;5721.370649228665;5752.194692743019;6028.336882942873;6052.334243233241;6085.6348619083;6106;6114.11345354921;5462.918056229159;5492.066348720727;5555.583331250173;5626.774929002876;5693.202951586781;5293.894122117536;5355.410904800468;5364.892702146013;5392.245085688007;5394.62237643369;6135;6174.104754810617;6192.628442293477;6199.659018754011;6211.0372892201785;5805.158252053513;5833.649981001154;5912.172295878667;5942.078977758454;6100.328963813889;6098.939010609837;6140.499915048558;6153.723082461211;6157.076438534255;6169.259688837189;5929.495992840484;5991.67045812467;5993.250843644544;5996.2504686914135;6018.548608854266;5760.711964401679;5822.097574875901;5836.153757705194;6085.969570152298;6094.177286066324;5708;5778.624389414843;5812.622179558315;5834.649921004753;5855.707214639337;5730.512906402836;5904.527637789052;5916.55625828056;5949.405059494016;5978.491828194652;5513.42109078557;5806.76772929095;5842.912356314744;5848.444397782204;5853.414658534283;5719.914201287067;5740.770369185186;5768.336641286306;5827.766889324549;5833.941660583339;5662.688552129673;5778.682172480386;5816.47651711348;5828.213191219131;5849.824505264849 16:19:54 INFO - 2015-11-09 16:19:54,751 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.1160829524393;577.168876817383;587.8794847056353;588.9941100588994;590.3093380744534;34329.31341373171;41170.17659646805;42144.57855421445;42177.78911105448;42180.36729449061;43551;44054.55945440545;44151.558484415145;44153.33769993453;44182;8667.566621668891;8837.911620883773;9417.57620907059;9598.472084035375;9608.423494590346;11322.490487928064;11523.13576481763;11526.077913766878;11548.595799147031;11568.71078223047;11157.66527004191;11319.151063670217;11320.716982075432;11321.094312455025;11345.943270283637;8872.556372181365;9090.090990900922;11103.611373601925;11189.888101119048;11226.382548959804;11032.338059716363;11126.499307531181;11132.276402033842;11170.218084733991;11171.218014738972;41531.1693766126;41980.16039679189;42094.78952605248;42112.78943605293;42194.15611687749;3221.0658908916384;3274.6889045540875;3303.3723592517345;3517.6482351764876;3532.7880327180196;29257.41485170306;30291.545626815616;30884.53673194904;30915.845420772977;31919;2347.7065366829147;2379.0364902214633;2405.2183040511727;2408.4099395648004;2418.4437579356672;287454;289523;290141;290415;290542;60274.09588856171;61020.38979610236;63288;64184.67907660525;64776.67611662006;60966.085508717406;61371.38628613657;61729.382706172364;61734.69132654308;61749.69125154345;17183.226754796066;17357.218925148398;17362.305507779547;17370.305187792346;17370.436660700598;13292.734145317232;13354.131981421177;13357.599272021855;13376.732465350638;13611.455541778218;21563.89218053931;21767.38791345017;21770.34688959302;21812.127514899545;21849.235276765237;9210.309226808016;9469.763255918657;9475;9477.194438472807;9486.857697134548;984.2913102566141;1033.421284080917;1042.697617690861;1072.0619457974271;1076.8384742288563;29300.56049159264;32766.34467310688;34477;34572.65427345745;34788.30423391518;961.7451375385529;1075.1882328841675;1088.3198001249218;1194.9103817213743;1207.7946749052683;14679;14780.852191477947;15621.14083725406;15651.37394504207;15943.760843587355;450702;458039;459065;459484;462526;55003;55500.722496388065;56967.71516142393;57411.425885741446;62097.37902620916;1477.2170749502782;1487.6727120033574;1489.8137732783619;1498.400639744111;1502.0762231227934;29394.412111758073;30627.693723063374;30737.385252295277;30770.384592307582;31179.220519486287;46175.76912115418;46803.53196467992;51699;52432;52454.73772631113;220996;221687;223981;224304;224354;30193;30224.395512089195;30934.845325773225;30997.225069372544;31434.52848207233;38358.80820595879;40134.598654014255;40158.79920600378;40831.38752918649;40848.387274191504;34909.30181396307;36471.27057458783;36672.81663591665;36706.26587468289;37109.62890371062;35498.82250588731;36226.27547449089;36317;36495.08762280964;36630.08424789402;35202.29595408129;36335.09162270858;36355;36363.27273454569;36407.63592364149;29313.267168320108;32664.673353267113;32782.18044548905;32790;32857.17857053593;25149.24552263435;25344.239672809847;25434.064789932967;25510.744892550836;25724.485510289316 16:19:54 INFO - 2015-11-09 16:19:54,751 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.1043974404372;357.1713624391412;361.4758600029954;364.99087522811936;368.9797061161637;18868.150933208006;19240.422787316384;19329;19465;19718.309859154913;18606.906965465154;18703.158357873894;19004.904975475103;19384.70922936157;19412.611747765037;5482.2873026506595;5615.185798059279;5623.0721930881355;5626.324841019084;5645.463680950324;5266.92099618506;5279.815206467774;5528.115501519757;5583.190437386576;5592.3009623797025;5506.779728810843;5531.751071201786;5535.225068490415;5540.612157149001;5553.250311207996;5412.810551630713;5506.5870059745475;5511.751971161308;5524.613277070606;5532.612717109804;4859.73271470069;4863.076015557032;4865.537773911473;4865.95134048662;4869.5130486951375;21848.990185256902;22163.335099947028;22269;22292.442688932744;22341.664875026887;2169.3383518026994;2249.6737972993988;2278.4076140203665;2296.2307626944994;2343.121329501437;13430.19418834873;13759.518416855462;13973.930130349385;14003.369848356848;14098.365573549216;1632.0697202594527;1704.5056933489273;1711.9657606847918;1728.4728157911832;1777.7333399989975;50612.74693626508;62901;64234;64883.3511664882;66072.33927660758;10237.74405639865;10487.161027117812;11077.944610277058;11282.323060616225;11428.828567571492;13816.93091534536;14302.49941252072;14311;14341;14407.495737649131;8913.866292005625;9054.773630659287;9063.229625481908;9086.182243597976;9120.224780893699;9105.863412048824;9110.772230694285;9122;9155.81688366229;9168.633254669738;6377.202849643794;6572.849751293505;6578.934210657832;6598.307177746364;6638.734450622018;1805.124514610413;1843.483824529134;1911.2546107018275;1915.5977244778753;1924.8652594318544;395.51549352044094;404.17548201668853;415.19659458947035;416.8353500367338;420.2855146251324;12208.267503949613;12618.242905425705;12637.368131593383;12640.178388404724;12732.490700371882;421.47315855181023;424.8831571317912;428.1608048225513;440.90961352922574;454.7726136931534;6419.614823110535;6466.515011374166;6557.8360540985905;6628.635425051572;6723.159605049369;564773;574637;616188;645853;653776;58659.413405866246;60485.69757151186;63420.68289658522;68092;68675.3132468679;442.0451824060015;448.7374885691907;449.60884030893334;450.03916637978153;450.360488106889;10764.407957562096;10868.456577171268;11020.228583999044;11062.944685276521;11090.889091108986;34794.65205347914;35184.824075879456;35393.64606353903;35713;36448;44379.33430998473;44889.4813838415;49089;49371.50628493669;49777.751111244215;6229.719662615103;6398.072279519351;6607.900881486686;6611.404973552403;6621.735130594722;12035.398230088636;12165.878341216829;12259.38703064861;12276.202046866925;12302.876971230173;10169.593216271267;10408.462974486622;10640.095591874777;10650.041496265374;10693.51879165455;9945;10182.694519164437;10300.072993430627;10339.948300258751;10503.789924201626;8823.382363234512;11001.339919604849;11074.723131921766;11272.7745445089;11299.209055366046;6592.670366481752;6605.339466053356;6608.207015158212;6613.66931653425;6626.768063117768;10135.493225338556;10658.573657053632;10853.891461085605;10855.40295283767;10939.07017903487 16:19:54 INFO - 2015-11-09 16:19:54,751 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1477.0177831741898;1478.5268714011513;1608.6621809420021;1784.9821501784982;1832.8727832383088;7491.737789177379;7768.883466747996;7870.212978702134;7875.763727088182;7887.014123234596;7860.449768516206;8065.395095367841;8074.91925080749;8077.394195435351;8105.432619716622;2235.407616981497;2266.875321857297;2268.1834539565743;2270.398344438717;2270.8637481751066;2309.515001849605;2315.305408377488;2348.3424641100432;2367.739548649647;2368.5854975379325;2268.9319320420414;2296.517731276434;2313.8843057847125;2322.4310044039235;2324.9883750581307;2265.988670056656;2269.920552780645;2289.828262880291;2305.3545007397956;2305.9308220753405;2279.9658005129936;2289.0157232390065;2301.3901316151064;2308.203669733939;2309.157157637467;7112.502124851262;7300.196978332379;7901.683932642687;7983.002124734408;7996.920030799675;4742.454617718972;4823.879403014917;4853.587445067174;4856.805727770885;4877.585405240558;2746.491898998692;2763.405867738426;2800.2579316480947;2800.3559181388396;2853.6432945881766;812.191869090253;815.404754529197;820.5076953827715;829.2081062585216;829.5561874397168;10449.582016719321;10544.683659490227;10549;10565.577376904914;10617.681469555926;4246.065865509583;4277.294246449301;4303.82784688609;4316.676249281317;4358.869233922987;9322.95338523303;9339.953300233456;9347.90652093484;9365.578548965314;9381.249500039981;4855.8057677693205;4860.3195552622665;4862.17343051682;4869.074875773592;4872.4153101628035;4407.735535867858;4409.5149533551285;4412.382266482631;4413.801378937956;4414.668899832525;3620.9318251115983;3681;3700.4634328022826;3703.79629120401;3719.1445967427644;1169.7368092179192;1175.629676651852;1182.846229990113;1191.5591231244496;1191.874853140425;1076.5048077884105;1086.6957251969461;1256.1395444120806;1353.2016110494856;1390.6940473095904;7499.02512673349;7532.284432978859;7554.395648348119;7577.204393538709;7639.69441222356;457.0607401789355;458.13184016288943;460.37389150754944;461.6699060171926;463.35130816856673;5625.09998400254;5991.161237426763;6050.757969681164;6061.060535616986;6081.695915204222;8706.129387061243;9367.391119577205;9455.05449455049;9464.148226659634;9488.098630630078;9208.217301529445;9270.841144856893;9360.812783744423;9395.154436100784;9574.186194173573;7428.368588669916;7455.0681164854395;7486.652402567481;7500.624968751432;7511.51175173612;7208.135023797178;7343.816404589928;7364.3003914628025;7382.5570465772225;7414.740484083031;8325.875111873205;8430.325573953945;8475.194856488624;8517.105703901248;8532.402731808963;8455.74632761018;8636.309095272489;8654.134586541295;8657.52383618907;8684.869726953975;7039.753608623673;7069.82325441868;7095.929040709527;7123.287671232835;7126.928730712627;7597.3162415382885;7627.771166865003;7631.1605723369275;7639.274268944441;7717.151113377637;7127.073480447509;7149.463790215651;7149.785506434815;7196.388306993964;7309.049823522908;7012.088428504262;7046.506744528039;7052.400545953651;7064.434845212473;7178.533395329287;7023.05188799526;7048.577085374894;7051.788446346618;7071;7072.611006394698;6492.253390860112;6520.608763474207;6557.311482294481;6588.472922166311;6592.538522303393;6612.5040621952585;6715.731370745311;6719.697613607302;6731.899021514779;6744 16:19:54 INFO - 2015-11-09 16:19:54,755 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.5507448975516;310.54195062283134;314.20036008358727;317.6014102301611;319.8896380748641;6172.783952561661;6210;6229.813105606828;6272.435480806726;6290.528210384216;6083.756649734017;6084.239470066242;6112.266528016644;6127.080937859323;6131.202943617334;4651.790669419885;4728.858134255961;4800.42394912611;4812.927806082903;4836.927446088312;4692.554207350297;4756.881077973044;4762.119007983517;4791.520847915215;4800.927986080212;4701.882452938669;4708.5526874947;4716;4723.291506274052;4733.810647574093;4563.406757121586;4599.011212589309;4647.326137710047;4654.301854721819;4730.645201609876;3958.5249770027494;3975.264576053439;3978.1844721831953;3978.204359128157;3983.6813054955533;5931.347551769302;5987.64074155552;5988;5994.880102397971;6006.279246490449;5052.393712754456;5151.716655583941;5164.690118592859;5182;5186.740662966837;6483.092367068614;6512.479001679854;6523.315051919575;6532.542722009462;6546.836329091763;4307.612314891675;4309.892252693677;4310.4611923509565;4311.956880431187;4314.633256173229;6840.042394064835;6849.04113424121;6852.725890964355;6861.039454476378;6875.312468753134;4256.723312984646;4353.499347575006;4354.825806967686;4358.150160718629;4366.366876802846;4412.84555040572;4430.977845110754;4431.778411079433;4441.267190913463;4447.844325448594;5168.767405466763;5175.767090480862;5181.35233095863;5188.221766734944;5189.195674670432;6432.839179020562;6434.903476447857;6455.935440645628;6470.838229044218;6477.222733272038;1554.7978762760995;1563.5543869996995;1600.0079950430575;1604.502604192704;1605.3257631794675;1001.3891526169031;1003.5584342889106;1013.6958912326272;1016.0550687860214;1023.8976102389702;6141.140240366352;6146.754129834757;6152.507799376039;6153;6153.723082461211;6760.526763126534;6772.966135169391;6793.777120118426;6796.932030679729;6803.115594972721;6131.693415329216;6307.810765677037;6315.336889626523;6317.084022816666;6319;3712.1276500022473;3718.9772812476244;3743.737938344344;3763.1156678180605;3766.9434958475645;6849.726010959505;6859.862802743917;6865.759698410531;6868.381845633917;6895.931040689629;6713.261541230559;6909;6924.93075069253;6943.305669433016;6960.547564408297;6799.422049125781;6801.863962720718;6818.147731533559;6842.623655698984;6853.109095817512;6728.293529179366;6744.0558321834005;6746.089277947414;6753.189617245962;6768.526203165731;6534.411902928759;6596.274409815012;6606.966965165336;6608.669566521751;6640.037194606658;6781.287964763629;6796.558223715443;6804.251532331341;6836.794896153124;6837.794866154023;4238.427812245307;4256.212600668886;4260.8721738347895;4264.232438161161;4268.338407546835;6584.111144995364;6738.326167383222;6742.831429214113;6743.730250789913;6756.797296081126;6520.152380190545;6541.378569035934;6642.402183803288;6658.700358483977;6661.4004739573675;6577.046328282468;6585.539012269287;6618;6620.66896655175;6643.966780166068;6305.8108256752375;6457.903131453126;6483.481321494363;6484.027395890655;6486.481081513373;6327.11420401135;6457.515686323451;6466.773662921775;6541.149650545399;6554.737810487527;6350.7777227796805;6392.232932048184;6397.808065758035;6408.29508754046;6437.485001199799 16:19:54 INFO - 2015-11-09 16:19:54,756 DEBUG : BROWSER_OUTPUT: |5;yui.html;691.1636919327614;764.465795886636;780.7033327335612;783.4202690009395;792.2829838995708;13593.320333983298;14133.78799318011;14136.434542618283;14167.079139855901;14178.716425671493;12506;13021.869781302184;13132.409041593128;13143.737125257489;13187.274699891503;742.1576510660412;930.6044930904372;946.6970569417755;955.469714308562;955.5795450002012;937.8593211018334;944.36255527519;945.9668911588096;954.3367359685021;954.766082309835;798.66456088443;803.3613277444446;969.8399764038925;988.2834944665132;995.6863587969802;969.4038166527605;979.9657012004582;980.8626792249091;981.3768257156721;981.9558119884587;721.2895298131336;724.8985142080113;725.7387340557448;726.1830440754152;729.4711334282656;14227;14466.71066578673;14497.637559061002;14502.1298722077;14531.564053078318;11585.536578536932;11861.881381186164;12132.43367336753;12157.331346775924;12921.224726516439;9526.476043817587;9539.761505962337;9858.309918305722;10012.24908131893;10187.694369168938;3371.898843034713;3401.0647072055135;3516.5604299462566;3523.9119022024397;3525.995091398939;44660.3300950486;45530.31704524468;49803;50072.24891626628;50073;8983.101689830964;9330.300227482965;9391.530423478798;9425.76435589102;9566.186874115778;19156.808431915782;19180.520486987938;19192.520186995436;19237.422877313704;20593.485162870747;7020.227774944752;7165.92834071663;7385.926140738524;7495.325420712162;7508.2867127622785;4172.645325147397;4181.937270940938;4236.894077648083;4262.573742625775;4273.850415235452;3104;3157.0528841347505;3157.3369592385857;3166.477531207325;3183.029176101265;455.45800497407976;467.1031619290969;468.9788959496831;470.5388719055345;470.80696914264985;466.5357968820977;472.98344557940305;488.4748894937885;490.8920037591724;530.2920600997634;7365.558066516026;7469.365103966224;7608.771736847903;7934.894193145229;8011.078725946474;433.47549465147523;497.21688340863284;497.9701217926936;511.35569182829903;513.6327525819057;3582.194006348551;3985.3025720498795;4072.775997320176;4079.1637714268504;4093.761957531783;54143.72928135413;54655;54792;54919.45080549223;62905.37094628995;47386.5261347389;47740.52259477361;48856;51401.48598513967;51747.48252517502;47356.76321618439;47504;47835;47836.760816195696;47915.281270780964;8102.351811855156;8289.212524810133;8405.117462666332;8531.91468085336;8601.82796344082;34481;34655.480167796995;35366.64633353634;35379.292414152085;35509.82245088758;43258.26966921288;45321;46899.53100468952;47399;47422.525774741815;7801.4929029612895;7889.447738658469;8067.0722866871065;8100.2304781045705;8215.958920205361;11137.387443690675;11199;11552.191346605658;11721.12091593117;11922.344271065174;10520.842187367043;10539.156867450432;11039.116870650168;11044.33733975964;11338.659840204808;10626.628068017582;10943.45282735844;11369.658910232707;11442.48508817122;11628.069754419796;10113.19094472455;10186.490675466346;10390.740231494274;10729.302595331279;11178.88821111811;8021.117677055636;8486.40595158333;8529.317654587494;8802.163794439519;9547.904520954702;9223.400478968846;9856;9990.100890919852;10030.247731420026;10035.498225088862 16:19:54 INFO - 2015-11-09 16:19:54,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:19:54 INFO - 2015-11-09 16:19:54,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1081 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1447114794742__endTimestamp 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:19:54 INFO - 2015-11-09 16:19:54,757 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:19:54 INFO - 2015-11-09 16:19:54,758 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,758 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5601.53 Median:5740.77 stddev:589.01 (10.3%) stddev-sans-first:560.37 16:19:54 INFO - 2015-11-09 16:19:54,758 DEBUG : BROWSER_OUTPUT: Values: 3218.5 3321.0 3323.7 3338.7 3348.0 5535.1 5642.3 5659.5 5664.5 5685.1 5592.4 5619.9 5627.4 5636.0 5636.9 5132.6 5184.3 5219.2 5219.3 5306.4 5186.6 5241.2 5319.8 5320.3 5384.6 5247.9 5296.5 5297.0 5314.3 5321.4 5256.8 5266.8 5328.4 5343.6 5365.5 5086.7 5142.6 5159.6 5192.2 5239.7 5576.6 5604.8 5651.1 5681.8 5697.8 5797.7 6047.9 6051.2 6075.5 6098.6 5951.7 5970.3 6011.5 6018.5 6057.2 5599.9 5602.7 5614.6 5628.4 5704.7 6016.7 6060.9 6087.4 6149.1 6154.7 5775.4 5837.9 5839.0 5879.4 5912.1 6085.6 6099.1 6149.0 6153.8 6175.3 5617.3 5658.2 5707.9 6007.6 6034.5 5915.3 6031.5 6034.5 6035.3 6059.4 4722.3 4724.8 4732.3 4771.1 4795.9 4062.8 4113.0 4237.7 4241.7 4292.5 5645.7 5656.6 5707.9 5721.4 5752.2 6028.3 6052.3 6085.6 6106.0 6114.1 5462.9 5492.1 5555.6 5626.8 5693.2 5293.9 5355.4 5364.9 5392.2 5394.6 6135.0 6174.1 6192.6 6199.7 6211.0 5805.2 5833.6 5912.2 5942.1 6100.3 6098.9 6140.5 6153.7 6157.1 6169.3 5929.5 5991.7 5993.3 5996.3 6018.5 5760.7 5822.1 5836.2 6086.0 6094.2 5708.0 5778.6 5812.6 5834.6 5855.7 5730.5 5904.5 5916.6 5949.4 5978.5 5513.4 5806.8 5842.9 5848.4 5853.4 5719.9 5740.8 5768.3 5827.8 5833.9 5662.7 5778.7 5816.5 5828.2 5849.8 16:19:54 INFO - 2015-11-09 16:19:54,758 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,759 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50019.01 Median:18020.52 stddev:89255.58 (495.3%) stddev-sans-first:89428.70 16:19:54 INFO - 2015-11-09 16:19:54,760 DEBUG : BROWSER_OUTPUT: Values: 554.1 577.2 587.9 589.0 590.3 34329.3 41170.2 42144.6 42177.8 42180.4 43551.0 44054.6 44151.6 44153.3 44182.0 8667.6 8837.9 9417.6 9598.5 9608.4 11322.5 11523.1 11526.1 11548.6 11568.7 11157.7 11319.2 11320.7 11321.1 11345.9 8872.6 9090.1 11103.6 11189.9 11226.4 11032.3 11126.5 11132.3 11170.2 11171.2 41531.2 41980.2 42094.8 42112.8 42194.2 3221.1 3274.7 3303.4 3517.6 3532.8 29257.4 30291.5 30884.5 30915.8 31919.0 2347.7 2379.0 2405.2 2408.4 2418.4 287454.0 289523.0 290141.0 290415.0 290542.0 60274.1 61020.4 63288.0 64184.7 64776.7 60966.1 61371.4 61729.4 61734.7 61749.7 17183.2 17357.2 17362.3 17370.3 17370.4 13292.7 13354.1 13357.6 13376.7 13611.5 21563.9 21767.4 21770.3 21812.1 21849.2 9210.3 9469.8 9475.0 9477.2 9486.9 984.3 1033.4 1042.7 1072.1 1076.8 29300.6 32766.3 34477.0 34572.7 34788.3 961.7 1075.2 1088.3 1194.9 1207.8 14679.0 14780.9 15621.1 15651.4 15943.8 450702.0 458039.0 459065.0 459484.0 462526.0 55003.0 55500.7 56967.7 57411.4 62097.4 1477.2 1487.7 1489.8 1498.4 1502.1 29394.4 30627.7 30737.4 30770.4 31179.2 46175.8 46803.5 51699.0 52432.0 52454.7 220996.0 221687.0 223981.0 224304.0 224354.0 30193.0 30224.4 30934.8 30997.2 31434.5 38358.8 40134.6 40158.8 40831.4 40848.4 34909.3 36471.3 36672.8 36706.3 37109.6 35498.8 36226.3 36317.0 36495.1 36630.1 35202.3 36335.1 36355.0 36363.3 36407.6 29313.3 32664.7 32782.2 32790.0 32857.2 25149.2 25344.2 25434.1 25510.7 25724.5 16:19:54 INFO - 2015-11-09 16:19:54,760 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,760 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29886.70 Median:416.02 stddev:99873.87 (24007.2%) stddev-sans-first:100129.43 16:19:54 INFO - 2015-11-09 16:19:54,761 DEBUG : BROWSER_OUTPUT: Values: 356.1 357.2 361.5 365.0 369.0 18868.2 19240.4 19329.0 19465.0 19718.3 18606.9 18703.2 19004.9 19384.7 19412.6 5482.3 5615.2 5623.1 5626.3 5645.5 5266.9 5279.8 5528.1 5583.2 5592.3 5506.8 5531.8 5535.2 5540.6 5553.3 5412.8 5506.6 5511.8 5524.6 5532.6 4859.7 4863.1 4865.5 4866.0 4869.5 21849.0 22163.3 22269.0 22292.4 22341.7 2169.3 2249.7 2278.4 2296.2 2343.1 13430.2 13759.5 13973.9 14003.4 14098.4 1632.1 1704.5 1712.0 1728.5 1777.7 50612.7 62901.0 64234.0 64883.4 66072.3 10237.7 10487.2 11077.9 11282.3 11428.8 13816.9 14302.5 14311.0 14341.0 14407.5 8913.9 9054.8 9063.2 9086.2 9120.2 9105.9 9110.8 9122.0 9155.8 9168.6 6377.2 6572.8 6578.9 6598.3 6638.7 1805.1 1843.5 1911.3 1915.6 1924.9 395.5 404.2 415.2 416.8 420.3 12208.3 12618.2 12637.4 12640.2 12732.5 421.5 424.9 428.2 440.9 454.8 6419.6 6466.5 6557.8 6628.6 6723.2 564773.0 574637.0 616188.0 645853.0 653776.0 58659.4 60485.7 63420.7 68092.0 68675.3 442.0 448.7 449.6 450.0 450.4 10764.4 10868.5 11020.2 11062.9 11090.9 34794.7 35184.8 35393.6 35713.0 36448.0 44379.3 44889.5 49089.0 49371.5 49777.8 6229.7 6398.1 6607.9 6611.4 6621.7 12035.4 12165.9 12259.4 12276.2 12302.9 10169.6 10408.5 10640.1 10650.0 10693.5 9945.0 10182.7 10300.1 10339.9 10503.8 8823.4 11001.3 11074.7 11272.8 11299.2 6592.7 6605.3 6608.2 6613.7 6626.8 10135.5 10658.6 10853.9 10855.4 10939.1 16:19:54 INFO - 2015-11-09 16:19:54,762 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,762 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5512.67 Median:6664.12 stddev:2886.66 (43.3%) stddev-sans-first:2878.82 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: Values: 1477.0 1478.5 1608.7 1785.0 1832.9 7491.7 7768.9 7870.2 7875.8 7887.0 7860.4 8065.4 8074.9 8077.4 8105.4 2235.4 2266.9 2268.2 2270.4 2270.9 2309.5 2315.3 2348.3 2367.7 2368.6 2268.9 2296.5 2313.9 2322.4 2325.0 2266.0 2269.9 2289.8 2305.4 2305.9 2280.0 2289.0 2301.4 2308.2 2309.2 7112.5 7300.2 7901.7 7983.0 7996.9 4742.5 4823.9 4853.6 4856.8 4877.6 2746.5 2763.4 2800.3 2800.4 2853.6 812.2 815.4 820.5 829.2 829.6 10449.6 10544.7 10549.0 10565.6 10617.7 4246.1 4277.3 4303.8 4316.7 4358.9 9323.0 9340.0 9347.9 9365.6 9381.2 4855.8 4860.3 4862.2 4869.1 4872.4 4407.7 4409.5 4412.4 4413.8 4414.7 3620.9 3681.0 3700.5 3703.8 3719.1 1169.7 1175.6 1182.8 1191.6 1191.9 1076.5 1086.7 1256.1 1353.2 1390.7 7499.0 7532.3 7554.4 7577.2 7639.7 457.1 458.1 460.4 461.7 463.4 5625.1 5991.2 6050.8 6061.1 6081.7 8706.1 9367.4 9455.1 9464.1 9488.1 9208.2 9270.8 9360.8 9395.2 9574.2 7428.4 7455.1 7486.7 7500.6 7511.5 7208.1 7343.8 7364.3 7382.6 7414.7 8325.9 8430.3 8475.2 8517.1 8532.4 8455.7 8636.3 8654.1 8657.5 8684.9 7039.8 7069.8 7095.9 7123.3 7126.9 7597.3 7627.8 7631.2 7639.3 7717.2 7127.1 7149.5 7149.8 7196.4 7309.0 7012.1 7046.5 7052.4 7064.4 7178.5 7023.1 7048.6 7051.8 7071.0 7072.6 6492.3 6520.6 6557.3 6588.5 6592.5 6612.5 6715.7 6719.7 6731.9 6744.0 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5403.30 Median:6163.25 stddev:1669.86 (27.1%) stddev-sans-first:1630.08 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: Values: 303.6 310.5 314.2 317.6 319.9 6172.8 6210.0 6229.8 6272.4 6290.5 6083.8 6084.2 6112.3 6127.1 6131.2 4651.8 4728.9 4800.4 4812.9 4836.9 4692.6 4756.9 4762.1 4791.5 4800.9 4701.9 4708.6 4716.0 4723.3 4733.8 4563.4 4599.0 4647.3 4654.3 4730.6 3958.5 3975.3 3978.2 3978.2 3983.7 5931.3 5987.6 5988.0 5994.9 6006.3 5052.4 5151.7 5164.7 5182.0 5186.7 6483.1 6512.5 6523.3 6532.5 6546.8 4307.6 4309.9 4310.5 4312.0 4314.6 6840.0 6849.0 6852.7 6861.0 6875.3 4256.7 4353.5 4354.8 4358.2 4366.4 4412.8 4431.0 4431.8 4441.3 4447.8 5168.8 5175.8 5181.4 5188.2 5189.2 6432.8 6434.9 6455.9 6470.8 6477.2 1554.8 1563.6 1600.0 1604.5 1605.3 1001.4 1003.6 1013.7 1016.1 1023.9 6141.1 6146.8 6152.5 6153.0 6153.7 6760.5 6773.0 6793.8 6796.9 6803.1 6131.7 6307.8 6315.3 6317.1 6319.0 3712.1 3719.0 3743.7 3763.1 3766.9 6849.7 6859.9 6865.8 6868.4 6895.9 6713.3 6909.0 6924.9 6943.3 6960.5 6799.4 6801.9 6818.1 6842.6 6853.1 6728.3 6744.1 6746.1 6753.2 6768.5 6534.4 6596.3 6607.0 6608.7 6640.0 6781.3 6796.6 6804.3 6836.8 6837.8 4238.4 4256.2 4260.9 4264.2 4268.3 6584.1 6738.3 6742.8 6743.7 6756.8 6520.2 6541.4 6642.4 6658.7 6661.4 6577.0 6585.5 6618.0 6620.7 6644.0 6305.8 6457.9 6483.5 6484.0 6486.5 6327.1 6457.5 6466.8 6541.1 6554.7 6350.8 6392.2 6397.8 6408.3 6437.5 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: 16:19:54 INFO - 2015-11-09 16:19:54,764 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13620.27 Median:47463.26 stddev:15980.05 (33.7%) stddev-sans-first:15995.38 16:19:54 INFO - 2015-11-09 16:19:54,766 DEBUG : BROWSER_OUTPUT: Values: 691.2 764.5 780.7 783.4 792.3 13593.3 14133.8 14136.4 14167.1 14178.7 12506.0 13021.9 13132.4 13143.7 13187.3 742.2 930.6 946.7 955.5 955.6 937.9 944.4 946.0 954.3 954.8 798.7 803.4 969.8 988.3 995.7 969.4 980.0 980.9 981.4 982.0 721.3 724.9 725.7 726.2 729.5 14227.0 14466.7 14497.6 14502.1 14531.6 11585.5 11861.9 12132.4 12157.3 12921.2 9526.5 9539.8 9858.3 10012.2 10187.7 3371.9 3401.1 3516.6 3523.9 3526.0 44660.3 45530.3 49803.0 50072.2 50073.0 8983.1 9330.3 9391.5 9425.8 9566.2 19156.8 19180.5 19192.5 19237.4 20593.5 7020.2 7165.9 7385.9 7495.3 7508.3 4172.6 4181.9 4236.9 4262.6 4273.9 3104.0 3157.1 3157.3 3166.5 3183.0 455.5 467.1 469.0 470.5 470.8 466.5 473.0 488.5 490.9 530.3 7365.6 7469.4 7608.8 7934.9 8011.1 433.5 497.2 498.0 511.4 513.6 3582.2 3985.3 4072.8 4079.2 4093.8 54143.7 54655.0 54792.0 54919.5 62905.4 47386.5 47740.5 48856.0 51401.5 51747.5 47356.8 47504.0 47835.0 47836.8 47915.3 8102.4 8289.2 8405.1 8531.9 8601.8 34481.0 34655.5 35366.6 35379.3 35509.8 43258.3 45321.0 46899.5 47399.0 47422.5 7801.5 7889.4 8067.1 8100.2 8216.0 11137.4 11199.0 11552.2 11721.1 11922.3 10520.8 10539.2 11039.1 11044.3 11338.7 10626.6 10943.5 11369.7 11442.5 11628.1 10113.2 10186.5 10390.7 10729.3 11178.9 8021.1 8486.4 8529.3 8802.2 9547.9 9223.4 9856.0 9990.1 10030.2 10035.5 16:19:54 INFO - 2015-11-09 16:19:54,766 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:19:54 INFO - 2015-11-09 16:19:54,766 DEBUG : BROWSER_OUTPUT: 16:19:55 INFO - 2015-11-09 16:19:55,487 INFO : Browser exited with error code: 0 16:19:55 INFO - 2015-11-09 16:19:55,515 INFO : Completed test dromaeo_css (00:18:33) 16:19:55 INFO - 2015-11-09 16:19:55,515 INFO : Starting test kraken 16:19:55 INFO - 2015-11-09 16:19:55,515 DEBUG : operating with platform_type : mac_ 16:19:55 INFO - 2015-11-09 16:19:55,515 INFO : Initialising browser for kraken test... 16:19:55 INFO - 2015-11-09 16:19:55,528 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpIlzzm8/profile http://localhost:49270/getInfo.html 16:19:57 INFO - 2015-11-09 16:19:57,578 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:19:57 INFO - 2015-11-09 16:19:57,578 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:19:57 INFO - 2015-11-09 16:19:57,578 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:19:57 INFO - 2015-11-09 16:19:57,578 DEBUG : BROWSER_OUTPUT: __metrics 16:19:57 INFO - 2015-11-09 16:19:57,594 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:58 INFO - 2015-11-09 16:19:58,373 INFO : Browser initialized. 16:19:58 INFO - 2015-11-09 16:19:58,374 INFO : Running cycle 1/1 for kraken test... 16:19:58 INFO - 2015-11-09 16:19:58,374 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpIlzzm8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:20:10 INFO - 2015-11-09 16:20:10,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 203935744 16:20:10 INFO - 2015-11-09 16:20:10,186 DEBUG : BROWSER_OUTPUT: 16:20:12 INFO - 2015-11-09 16:20:12,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 16:20:13 INFO - 2015-11-09 16:20:13,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 271073280 16:20:13 INFO - 2015-11-09 16:20:13,370 DEBUG : BROWSER_OUTPUT: 16:20:15 INFO - 2015-11-09 16:20:15,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 16:20:16 INFO - 2015-11-09 16:20:16,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 282546176 16:20:16 INFO - 2015-11-09 16:20:16,556 DEBUG : BROWSER_OUTPUT: 16:20:19 INFO - 2015-11-09 16:20:19,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 16:20:19 INFO - 2015-11-09 16:20:19,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 270098432 16:20:19 INFO - 2015-11-09 16:20:19,955 DEBUG : BROWSER_OUTPUT: 16:20:22 INFO - 2015-11-09 16:20:22,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 16:20:22 INFO - 2015-11-09 16:20:22,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 270925824 16:20:22 INFO - 2015-11-09 16:20:22,606 DEBUG : BROWSER_OUTPUT: 16:20:24 INFO - 2015-11-09 16:20:24,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:20:25 INFO - 2015-11-09 16:20:25,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 270426112 16:20:25 INFO - 2015-11-09 16:20:25,344 DEBUG : BROWSER_OUTPUT: 16:20:28 INFO - 2015-11-09 16:20:28,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 16:20:28 INFO - 2015-11-09 16:20:28,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 271450112 16:20:28 INFO - 2015-11-09 16:20:28,952 DEBUG : BROWSER_OUTPUT: 16:20:32 INFO - 2015-11-09 16:20:32,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 16:20:32 INFO - 2015-11-09 16:20:32,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 271683584 16:20:32 INFO - 2015-11-09 16:20:32,633 DEBUG : BROWSER_OUTPUT: 16:20:35 INFO - 2015-11-09 16:20:35,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 16:20:36 INFO - 2015-11-09 16:20:36,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 272433152 16:20:36 INFO - 2015-11-09 16:20:36,065 DEBUG : BROWSER_OUTPUT: 16:20:37 INFO - 2015-11-09 16:20:37,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:20:38 INFO - 2015-11-09 16:20:38,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 304492544 16:20:38 INFO - 2015-11-09 16:20:38,221 DEBUG : BROWSER_OUTPUT: 16:20:40 INFO - 2015-11-09 16:20:40,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:20:40 INFO - 2015-11-09 16:20:40,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 305631232 16:20:40 INFO - 2015-11-09 16:20:40,633 DEBUG : BROWSER_OUTPUT: 16:20:42 INFO - 2015-11-09 16:20:42,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:20:43 INFO - 2015-11-09 16:20:43,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 312627200 16:20:43 INFO - 2015-11-09 16:20:43,263 DEBUG : BROWSER_OUTPUT: 16:20:45 INFO - 2015-11-09 16:20:45,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:20:46 INFO - 2015-11-09 16:20:46,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 315031552 16:20:46 INFO - 2015-11-09 16:20:46,354 DEBUG : BROWSER_OUTPUT: 16:20:48 INFO - 2015-11-09 16:20:48,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:20:49 INFO - 2015-11-09 16:20:49,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 314073088 16:20:49 INFO - 2015-11-09 16:20:49,458 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 372084736 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;106;108;107;109;108;110;96;107 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;126;148;161;126;145;127;155;146;126 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;161;159;159;161;161;161;161 16:20:51 INFO - 2015-11-09 16:20:51,429 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;79;115;118;65;69;70;70;119;66 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;97;136;88;88;92;122;87;87;125 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;120;114;120;120;114;120;120;120;120 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;124;124;124;124;124;124;124;124;124 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;99;101;100;101;100;100;100;100;100 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;62;62;62;63;64;71;57;56 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;66;65;66;65;65;66 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;82;82;83;82;83;82;84;87 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;116;120;116;126;123;119;120;131;118 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;135;144;143;148;136;145;146;144;136 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;68;69;69;68;71;69;68 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:20:51 INFO - 2015-11-09 16:20:51,430 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:20:51 INFO - 2015-11-09 16:20:51,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,879 16:20:51 INFO - 2015-11-09 16:20:51,431 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:20:51 INFO - 2015-11-09 16:20:51,431 DEBUG : BROWSER_OUTPUT: __startTimestamp1447114851427__endTimestamp 16:20:51 INFO - 2015-11-09 16:20:51,431 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,431 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:4.08 (3.7%) stddev-sans-first:4.27 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 106.0 108.0 107.0 109.0 108.0 110.0 96.0 107.0 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,432 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:147.00 stddev:13.84 (9.4%) stddev-sans-first:13.91 16:20:51 INFO - 2015-11-09 16:20:51,433 DEBUG : BROWSER_OUTPUT: Values: 154.0 126.0 148.0 161.0 126.0 145.0 127.0 155.0 146.0 126.0 16:20:51 INFO - 2015-11-09 16:20:51,433 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,434 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 16:20:51 INFO - 2015-11-09 16:20:51,434 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 161.0 159.0 159.0 161.0 161.0 161.0 161.0 16:20:51 INFO - 2015-11-09 16:20:51,434 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.80 Median:69.50 stddev:22.88 (32.9%) stddev-sans-first:24.09 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 115.0 118.0 65.0 69.0 70.0 70.0 119.0 66.0 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.10 Median:88.00 stddev:18.44 (21.0%) stddev-sans-first:19.53 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: Values: 99.0 97.0 136.0 88.0 88.0 92.0 122.0 87.0 87.0 125.0 16:20:51 INFO - 2015-11-09 16:20:51,435 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:120.00 stddev:2.60 (2.2%) stddev-sans-first:2.65 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: Values: 121.0 120.0 114.0 120.0 120.0 114.0 120.0 120.0 120.0 120.0 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.00 Median:124.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 16:20:51 INFO - 2015-11-09 16:20:51,436 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,437 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.20 Median:100.50 stddev:0.63 (0.6%) stddev-sans-first:0.60 16:20:51 INFO - 2015-11-09 16:20:51,437 DEBUG : BROWSER_OUTPUT: Values: 101.0 99.0 101.0 100.0 101.0 100.0 100.0 100.0 100.0 100.0 16:20:51 INFO - 2015-11-09 16:20:51,437 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,437 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:4.24 (6.8%) stddev-sans-first:4.28 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 62.0 62.0 62.0 63.0 64.0 71.0 57.0 56.0 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 66.0 65.0 66.0 65.0 65.0 66.0 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.66 (2.0%) stddev-sans-first:1.76 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 82.0 82.0 83.0 82.0 83.0 82.0 84.0 87.0 16:20:51 INFO - 2015-11-09 16:20:51,438 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,439 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:4.64 (3.9%) stddev-sans-first:4.92 16:20:51 INFO - 2015-11-09 16:20:51,439 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 120.0 116.0 126.0 123.0 119.0 120.0 131.0 118.0 16:20:51 INFO - 2015-11-09 16:20:51,439 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,440 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.50 stddev:4.79 (3.3%) stddev-sans-first:4.88 16:20:51 INFO - 2015-11-09 16:20:51,440 DEBUG : BROWSER_OUTPUT: Values: 146.0 135.0 144.0 143.0 148.0 136.0 145.0 146.0 144.0 136.0 16:20:51 INFO - 2015-11-09 16:20:51,440 DEBUG : BROWSER_OUTPUT: 16:20:51 INFO - 2015-11-09 16:20:51,440 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 16:20:51 INFO - 2015-11-09 16:20:51,441 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 69.0 69.0 68.0 71.0 69.0 68.0 16:20:51 INFO - 2015-11-09 16:20:51,441 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:20:51 INFO - 2015-11-09 16:20:51,441 DEBUG : BROWSER_OUTPUT: 16:20:52 INFO - 2015-11-09 16:20:52,065 INFO : Browser exited with error code: 0 16:20:52 INFO - 2015-11-09 16:20:52,113 INFO : Completed test kraken (00:00:56) 16:20:52 INFO - 2015-11-09 16:20:52,113 INFO : Starting test v8_7 16:20:52 INFO - 2015-11-09 16:20:52,113 DEBUG : operating with platform_type : mac_ 16:20:52 INFO - 2015-11-09 16:20:52,113 INFO : Initialising browser for v8_7 test... 16:20:52 INFO - 2015-11-09 16:20:52,126 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpNyGjU0/profile http://localhost:49270/getInfo.html 16:20:54 INFO - 2015-11-09 16:20:54,179 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:20:54 INFO - 2015-11-09 16:20:54,179 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:20:54 INFO - 2015-11-09 16:20:54,179 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:20:54 INFO - 2015-11-09 16:20:54,179 DEBUG : BROWSER_OUTPUT: __metrics 16:20:54 INFO - 2015-11-09 16:20:54,195 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:20:54 INFO - 2015-11-09 16:20:54,881 INFO : Browser initialized. 16:20:54 INFO - 2015-11-09 16:20:54,882 INFO : Running cycle 1/1 for v8_7 test... 16:20:54 INFO - 2015-11-09 16:20:54,882 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/T/tmpNyGjU0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:21:06 INFO - 2015-11-09 16:21:06,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 200200192 16:21:06 INFO - 2015-11-09 16:21:06,693 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 16:21:28 INFO - 2015-11-09 16:21:28,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 517599232 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.0219675262655 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.2032520325203 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 16:21:28 INFO - 2015-11-09 16:21:28,373 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1009.0817356205853 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: |5;Earley;675.219446320054 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: |7;RegExp;29200 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: |8;Splay;589.9705014749262 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5813.953488372093 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: __startTimestamp1447114888366__endTimestamp 16:21:28 INFO - 2015-11-09 16:21:28,374 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: Values: 165.9 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,375 DEBUG : BROWSER_OUTPUT: Values: 191.0 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.20 Median:325.20 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: Values: 325.2 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: Values: 5758.6 16:21:28 INFO - 2015-11-09 16:21:28,376 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1009.08 Median:1009.08 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: Values: 1009.1 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:675.22 Median:675.22 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: Values: 675.2 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,377 DEBUG : BROWSER_OUTPUT: Values: 12231.7 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29200.00 Median:29200.00 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: Values: 29200.0 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:589.97 Median:589.97 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: Values: 590.0 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5813.95 Median:5813.95 stddev:0.00 (0.0%) 16:21:28 INFO - 2015-11-09 16:21:28,378 DEBUG : BROWSER_OUTPUT: Values: 5814.0 16:21:28 INFO - 2015-11-09 16:21:28,379 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:21:28 INFO - 2015-11-09 16:21:28,379 DEBUG : BROWSER_OUTPUT: 16:21:29 INFO - 2015-11-09 16:21:29,005 INFO : Browser exited with error code: 0 16:21:29 INFO - 2015-11-09 16:21:29,025 INFO : Completed test v8_7 (00:00:36) 16:21:29 INFO - 2015-11-09 16:21:29,113 INFO : Completed test suite (00:20:07) 16:21:29 INFO - 2015-11-09 16:21:29,113 DEBUG : Working with test: dromaeo_css 16:21:29 INFO - 2015-11-09 16:21:29,113 DEBUG : Generating results file: dromaeo_css 16:21:29 INFO - 2015-11-09 16:21:29,114 DEBUG : Working with test: kraken 16:21:29 INFO - 2015-11-09 16:21:29,114 DEBUG : Generating results file: kraken 16:21:29 INFO - 2015-11-09 16:21:29,114 INFO : javascript benchmark 16:21:29 INFO - 2015-11-09 16:21:29,114 DEBUG : Working with test: v8_7 16:21:29 INFO - 2015-11-09 16:21:29,114 DEBUG : Generating results file: v8_7 16:21:29 INFO - 2015-11-09 16:21:29,115 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:21:29 INFO - 2015-11-09 16:21:29,169 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 16:21:29 INFO - 2015-11-09 16:21:29,169 DEBUG : process_Request line: dromaeo_css 6953.79 graph.html#tests=[[72,52,55]] 16:21:29 INFO - 2015-11-09 16:21:29,169 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:21:29 INFO - 2015-11-09 16:21:29,199 DEBUG : process_Request line: kraken 1480.50 graph.html#tests=[[232,52,55]] 16:21:29 INFO - 2015-11-09 16:21:29,199 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:21:29 INFO - 2015-11-09 16:21:29,228 DEBUG : process_Request line: v8_7 20425.25 graph.html#tests=[[230,52,55]] 16:21:29 INFO - 2015-11-09 16:21:29,229 INFO : javascript benchmark 16:21:29 INFO - 2015-11-09 16:21:29,231 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.1043974404372, 357.1713624391412, 361.4758600029954, 364.99087522811936, 368.9797061161637, 18868.150933208006, 19240.422787316384, 19329.0, 19465.0, 19718.309859154913, 18606.906965465154, 18703.158357873894, 19004.904975475103, 19384.70922936157, 19412.611747765037, 5482.2873026506595, 5615.185798059279, 5623.0721930881355, 5626.324841019084, 5645.463680950324, 5266.92099618506, 5279.815206467774, 5528.115501519757, 5583.190437386576, 5592.3009623797025, 5506.779728810843, 5531.751071201786, 5535.225068490415, 5540.612157149001, 5553.250311207996, 5412.810551630713, 5506.5870059745475, 5511.751971161308, 5524.613277070606, 5532.612717109804, 4859.73271470069, 4863.076015557032, 4865.537773911473, 4865.95134048662, 4869.5130486951375, 21848.990185256902, 22163.335099947028, 22269.0, 22292.442688932744, 22341.664875026887, 2169.3383518026994, 2249.6737972993988, 2278.4076140203665, 2296.2307626944994, 2343.121329501437, 13430.19418834873, 13759.518416855462, 13973.930130349385, 14003.369848356848, 14098.365573549216, 1632.0697202594527, 1704.5056933489273, 1711.9657606847918, 1728.4728157911832, 1777.7333399989975, 50612.74693626508, 62901.0, 64234.0, 64883.3511664882, 66072.33927660758, 10237.74405639865, 10487.161027117812, 11077.944610277058, 11282.323060616225, 11428.828567571492, 13816.93091534536, 14302.49941252072, 14311.0, 14341.0, 14407.495737649131, 8913.866292005625, 9054.773630659287, 9063.229625481908, 9086.182243597976, 9120.224780893699, 9105.863412048824, 9110.772230694285, 9122.0, 9155.81688366229, 9168.633254669738, 6377.202849643794, 6572.849751293505, 6578.934210657832, 6598.307177746364, 6638.734450622018, 1805.124514610413, 1843.483824529134, 1911.2546107018275, 1915.5977244778753, 1924.8652594318544, 395.51549352044094, 404.17548201668853, 415.19659458947035, 416.8353500367338, 420.2855146251324, 12208.267503949613, 12618.242905425705, 12637.368131593383, 12640.178388404724, 12732.490700371882, 421.47315855181023, 424.8831571317912, 428.1608048225513, 440.90961352922574, 454.7726136931534, 6419.614823110535, 6466.515011374166, 6557.8360540985905, 6628.635425051572, 6723.159605049369, 564773.0, 574637.0, 616188.0, 645853.0, 653776.0, 58659.413405866246, 60485.69757151186, 63420.68289658522, 68092.0, 68675.3132468679, 442.0451824060015, 448.7374885691907, 449.60884030893334, 450.03916637978153, 450.360488106889, 10764.407957562096, 10868.456577171268, 11020.228583999044, 11062.944685276521, 11090.889091108986, 34794.65205347914, 35184.824075879456, 35393.64606353903, 35713.0, 36448.0, 44379.33430998473, 44889.4813838415, 49089.0, 49371.50628493669, 49777.751111244215, 6229.719662615103, 6398.072279519351, 6607.900881486686, 6611.404973552403, 6621.735130594722, 12035.398230088636, 12165.878341216829, 12259.38703064861, 12276.202046866925, 12302.876971230173, 10169.593216271267, 10408.462974486622, 10640.095591874777, 10650.041496265374, 10693.51879165455, 9945.0, 10182.694519164437, 10300.072993430627, 10339.948300258751, 10503.789924201626, 8823.382363234512, 11001.339919604849, 11074.723131921766, 11272.7745445089, 11299.209055366046, 6592.670366481752, 6605.339466053356, 6608.207015158212, 6613.66931653425, 6626.768063117768, 10135.493225338556, 10658.573657053632, 10853.891461085605, 10855.40295283767, 10939.07017903487], "dojo.html": [3218.4528630132877, 3320.9833950830243, 3323.6842499962495, 3338.699517043467, 3348.012336360773, 5535.14205298179, 5642.322921249456, 5659.462351076651, 5664.518515926146, 5685.118806584986, 5592.4407559244055, 5619.943800561993, 5627.380988091307, 5636.0, 5636.915446268309, 5132.615053870956, 5184.300119483869, 5219.19102539107, 5219.295395121667, 5306.416294207634, 5186.636935414523, 5241.18761591952, 5319.787208511655, 5320.308359913206, 5384.623076384654, 5247.895042099156, 5296.470352964711, 5296.973515132419, 5314.3091398118195, 5321.4412486688925, 5256.816011439581, 5266.815661451869, 5328.440513746078, 5343.572514198855, 5365.490278423544, 5086.745662716887, 5142.588592912558, 5159.613029022838, 5192.247124167013, 5239.711815850127, 5576.581756368248, 5604.8318550443555, 5651.06757385031, 5681.801136960228, 5697.800576979786, 5797.739101740432, 6047.879042419127, 6051.152838602599, 6075.453209211148, 6098.60359076663, 5951.6726580038085, 5970.253718285215, 6011.549133814981, 6018.548608854353, 6057.212562366864, 5599.860003499904, 5602.663840169603, 5614.606977511617, 5628.437156284339, 5704.686242256675, 6016.69916504173, 6060.939390606126, 6087.391260873877, 6149.0776383542825, 6154.7230374633245, 5775.422457754275, 5837.941620583825, 5838.97817881869, 5879.3826648202175, 5912.054071348563, 6085.6348619083, 6099.115628233882, 6149.0, 6153.784617538365, 6175.320714721377, 5617.269754931915, 5658.179563963202, 5707.942920570824, 6007.579469437185, 6034.48706859913, 5915.349311575723, 6031.487323577458, 6034.547408944347, 6035.275766907999, 6059.36376680451, 4722.268048452495, 4724.811007559659, 4732.337472753748, 4771.141194584939, 4795.856124316276, 4062.8171732272117, 4113.01287690952, 4237.6821738369745, 4241.6606671466825, 4292.5063617683745, 5645.661260324311, 5656.604037717402, 5707.885842283131, 5721.370649228665, 5752.194692743019, 6028.336882942873, 6052.334243233241, 6085.6348619083, 6106.0, 6114.11345354921, 5462.918056229159, 5492.066348720727, 5555.583331250173, 5626.774929002876, 5693.202951586781, 5293.894122117536, 5355.410904800468, 5364.892702146013, 5392.245085688007, 5394.62237643369, 6135.0, 6174.104754810617, 6192.628442293477, 6199.659018754011, 6211.0372892201785, 5805.158252053513, 5833.649981001154, 5912.172295878667, 5942.078977758454, 6100.328963813889, 6098.939010609837, 6140.499915048558, 6153.723082461211, 6157.076438534255, 6169.259688837189, 5929.495992840484, 5991.67045812467, 5993.250843644544, 5996.2504686914135, 6018.548608854266, 5760.711964401679, 5822.097574875901, 5836.153757705194, 6085.969570152298, 6094.177286066324, 5708.0, 5778.624389414843, 5812.622179558315, 5834.649921004753, 5855.707214639337, 5730.512906402836, 5904.527637789052, 5916.55625828056, 5949.405059494016, 5978.491828194652, 5513.42109078557, 5806.76772929095, 5842.912356314744, 5848.444397782204, 5853.414658534283, 5719.914201287067, 5740.770369185186, 5768.336641286306, 5827.766889324549, 5833.941660583339, 5662.688552129673, 5778.682172480386, 5816.47651711348, 5828.213191219131, 5849.824505264849], "mootools.html": [1477.0177831741898, 1478.5268714011513, 1608.6621809420021, 1784.9821501784982, 1832.8727832383088, 7491.737789177379, 7768.883466747996, 7870.212978702134, 7875.763727088182, 7887.014123234596, 7860.449768516206, 8065.395095367841, 8074.91925080749, 8077.394195435351, 8105.432619716622, 2235.407616981497, 2266.875321857297, 2268.1834539565743, 2270.398344438717, 2270.8637481751066, 2309.515001849605, 2315.305408377488, 2348.3424641100432, 2367.739548649647, 2368.5854975379325, 2268.9319320420414, 2296.517731276434, 2313.8843057847125, 2322.4310044039235, 2324.9883750581307, 2265.988670056656, 2269.920552780645, 2289.828262880291, 2305.3545007397956, 2305.9308220753405, 2279.9658005129936, 2289.0157232390065, 2301.3901316151064, 2308.203669733939, 2309.157157637467, 7112.502124851262, 7300.196978332379, 7901.683932642687, 7983.002124734408, 7996.920030799675, 4742.454617718972, 4823.879403014917, 4853.587445067174, 4856.805727770885, 4877.585405240558, 2746.491898998692, 2763.405867738426, 2800.2579316480947, 2800.3559181388396, 2853.6432945881766, 812.191869090253, 815.404754529197, 820.5076953827715, 829.2081062585216, 829.5561874397168, 10449.582016719321, 10544.683659490227, 10549.0, 10565.577376904914, 10617.681469555926, 4246.065865509583, 4277.294246449301, 4303.82784688609, 4316.676249281317, 4358.869233922987, 9322.95338523303, 9339.953300233456, 9347.90652093484, 9365.578548965314, 9381.249500039981, 4855.8057677693205, 4860.3195552622665, 4862.17343051682, 4869.074875773592, 4872.4153101628035, 4407.735535867858, 4409.5149533551285, 4412.382266482631, 4413.801378937956, 4414.668899832525, 3620.9318251115983, 3681.0, 3700.4634328022826, 3703.79629120401, 3719.1445967427644, 1169.7368092179192, 1175.629676651852, 1182.846229990113, 1191.5591231244496, 1191.874853140425, 1076.5048077884105, 1086.6957251969461, 1256.1395444120806, 1353.2016110494856, 1390.6940473095904, 7499.02512673349, 7532.284432978859, 7554.395648348119, 7577.204393538709, 7639.69441222356, 457.0607401789355, 458.13184016288943, 460.37389150754944, 461.6699060171926, 463.35130816856673, 5625.09998400254, 5991.161237426763, 6050.757969681164, 6061.060535616986, 6081.695915204222, 8706.129387061243, 9367.391119577205, 9455.05449455049, 9464.148226659634, 9488.098630630078, 9208.217301529445, 9270.841144856893, 9360.812783744423, 9395.154436100784, 9574.186194173573, 7428.368588669916, 7455.0681164854395, 7486.652402567481, 7500.624968751432, 7511.51175173612, 7208.135023797178, 7343.816404589928, 7364.3003914628025, 7382.5570465772225, 7414.740484083031, 8325.875111873205, 8430.325573953945, 8475.194856488624, 8517.105703901248, 8532.402731808963, 8455.74632761018, 8636.309095272489, 8654.134586541295, 8657.52383618907, 8684.869726953975, 7039.753608623673, 7069.82325441868, 7095.929040709527, 7123.287671232835, 7126.928730712627, 7597.3162415382885, 7627.771166865003, 7631.1605723369275, 7639.274268944441, 7717.151113377637, 7127.073480447509, 7149.463790215651, 7149.785506434815, 7196.388306993964, 7309.049823522908, 7012.088428504262, 7046.506744528039, 7052.400545953651, 7064.434845212473, 7178.533395329287, 7023.05188799526, 7048.577085374894, 7051.788446346618, 7071.0, 7072.611006394698, 6492.253390860112, 6520.608763474207, 6557.311482294481, 6588.472922166311, 6592.538522303393, 6612.5040621952585, 6715.731370745311, 6719.697613607302, 6731.899021514779, 6744.0], "ext.html": [554.1160829524393, 577.168876817383, 587.8794847056353, 588.9941100588994, 590.3093380744534, 34329.31341373171, 41170.17659646805, 42144.57855421445, 42177.78911105448, 42180.36729449061, 43551.0, 44054.55945440545, 44151.558484415145, 44153.33769993453, 44182.0, 8667.566621668891, 8837.911620883773, 9417.57620907059, 9598.472084035375, 9608.423494590346, 11322.490487928064, 11523.13576481763, 11526.077913766878, 11548.595799147031, 11568.71078223047, 11157.66527004191, 11319.151063670217, 11320.716982075432, 11321.094312455025, 11345.943270283637, 8872.556372181365, 9090.090990900922, 11103.611373601925, 11189.888101119048, 11226.382548959804, 11032.338059716363, 11126.499307531181, 11132.276402033842, 11170.218084733991, 11171.218014738972, 41531.1693766126, 41980.16039679189, 42094.78952605248, 42112.78943605293, 42194.15611687749, 3221.0658908916384, 3274.6889045540875, 3303.3723592517345, 3517.6482351764876, 3532.7880327180196, 29257.41485170306, 30291.545626815616, 30884.53673194904, 30915.845420772977, 31919.0, 2347.7065366829147, 2379.0364902214633, 2405.2183040511727, 2408.4099395648004, 2418.4437579356672, 287454.0, 289523.0, 290141.0, 290415.0, 290542.0, 60274.09588856171, 61020.38979610236, 63288.0, 64184.67907660525, 64776.67611662006, 60966.085508717406, 61371.38628613657, 61729.382706172364, 61734.69132654308, 61749.69125154345, 17183.226754796066, 17357.218925148398, 17362.305507779547, 17370.305187792346, 17370.436660700598, 13292.734145317232, 13354.131981421177, 13357.599272021855, 13376.732465350638, 13611.455541778218, 21563.89218053931, 21767.38791345017, 21770.34688959302, 21812.127514899545, 21849.235276765237, 9210.309226808016, 9469.763255918657, 9475.0, 9477.194438472807, 9486.857697134548, 984.2913102566141, 1033.421284080917, 1042.697617690861, 1072.0619457974271, 1076.8384742288563, 29300.56049159264, 32766.34467310688, 34477.0, 34572.65427345745, 34788.30423391518, 961.7451375385529, 1075.1882328841675, 1088.3198001249218, 1194.9103817213743, 1207.7946749052683, 14679.0, 14780.852191477947, 15621.14083725406, 15651.37394504207, 15943.760843587355, 450702.0, 458039.0, 459065.0, 459484.0, 462526.0, 55003.0, 55500.722496388065, 56967.71516142393, 57411.425885741446, 62097.37902620916, 1477.2170749502782, 1487.6727120033574, 1489.8137732783619, 1498.400639744111, 1502.0762231227934, 29394.412111758073, 30627.693723063374, 30737.385252295277, 30770.384592307582, 31179.220519486287, 46175.76912115418, 46803.53196467992, 51699.0, 52432.0, 52454.73772631113, 220996.0, 221687.0, 223981.0, 224304.0, 224354.0, 30193.0, 30224.395512089195, 30934.845325773225, 30997.225069372544, 31434.52848207233, 38358.80820595879, 40134.598654014255, 40158.79920600378, 40831.38752918649, 40848.387274191504, 34909.30181396307, 36471.27057458783, 36672.81663591665, 36706.26587468289, 37109.62890371062, 35498.82250588731, 36226.27547449089, 36317.0, 36495.08762280964, 36630.08424789402, 35202.29595408129, 36335.09162270858, 36355.0, 36363.27273454569, 36407.63592364149, 29313.267168320108, 32664.673353267113, 32782.18044548905, 32790.0, 32857.17857053593, 25149.24552263435, 25344.239672809847, 25434.064789932967, 25510.744892550836, 25724.485510289316], "prototype.html": [303.5507448975516, 310.54195062283134, 314.20036008358727, 317.6014102301611, 319.8896380748641, 6172.783952561661, 6210.0, 6229.813105606828, 6272.435480806726, 6290.528210384216, 6083.756649734017, 6084.239470066242, 6112.266528016644, 6127.080937859323, 6131.202943617334, 4651.790669419885, 4728.858134255961, 4800.42394912611, 4812.927806082903, 4836.927446088312, 4692.554207350297, 4756.881077973044, 4762.119007983517, 4791.520847915215, 4800.927986080212, 4701.882452938669, 4708.5526874947, 4716.0, 4723.291506274052, 4733.810647574093, 4563.406757121586, 4599.011212589309, 4647.326137710047, 4654.301854721819, 4730.645201609876, 3958.5249770027494, 3975.264576053439, 3978.1844721831953, 3978.204359128157, 3983.6813054955533, 5931.347551769302, 5987.64074155552, 5988.0, 5994.880102397971, 6006.279246490449, 5052.393712754456, 5151.716655583941, 5164.690118592859, 5182.0, 5186.740662966837, 6483.092367068614, 6512.479001679854, 6523.315051919575, 6532.542722009462, 6546.836329091763, 4307.612314891675, 4309.892252693677, 4310.4611923509565, 4311.956880431187, 4314.633256173229, 6840.042394064835, 6849.04113424121, 6852.725890964355, 6861.039454476378, 6875.312468753134, 4256.723312984646, 4353.499347575006, 4354.825806967686, 4358.150160718629, 4366.366876802846, 4412.84555040572, 4430.977845110754, 4431.778411079433, 4441.267190913463, 4447.844325448594, 5168.767405466763, 5175.767090480862, 5181.35233095863, 5188.221766734944, 5189.195674670432, 6432.839179020562, 6434.903476447857, 6455.935440645628, 6470.838229044218, 6477.222733272038, 1554.7978762760995, 1563.5543869996995, 1600.0079950430575, 1604.502604192704, 1605.3257631794675, 1001.3891526169031, 1003.5584342889106, 1013.6958912326272, 1016.0550687860214, 1023.8976102389702, 6141.140240366352, 6146.754129834757, 6152.507799376039, 6153.0, 6153.723082461211, 6760.526763126534, 6772.966135169391, 6793.777120118426, 6796.932030679729, 6803.115594972721, 6131.693415329216, 6307.810765677037, 6315.336889626523, 6317.084022816666, 6319.0, 3712.1276500022473, 3718.9772812476244, 3743.737938344344, 3763.1156678180605, 3766.9434958475645, 6849.726010959505, 6859.862802743917, 6865.759698410531, 6868.381845633917, 6895.931040689629, 6713.261541230559, 6909.0, 6924.93075069253, 6943.305669433016, 6960.547564408297, 6799.422049125781, 6801.863962720718, 6818.147731533559, 6842.623655698984, 6853.109095817512, 6728.293529179366, 6744.0558321834005, 6746.089277947414, 6753.189617245962, 6768.526203165731, 6534.411902928759, 6596.274409815012, 6606.966965165336, 6608.669566521751, 6640.037194606658, 6781.287964763629, 6796.558223715443, 6804.251532331341, 6836.794896153124, 6837.794866154023, 4238.427812245307, 4256.212600668886, 4260.8721738347895, 4264.232438161161, 4268.338407546835, 6584.111144995364, 6738.326167383222, 6742.831429214113, 6743.730250789913, 6756.797296081126, 6520.152380190545, 6541.378569035934, 6642.402183803288, 6658.700358483977, 6661.4004739573675, 6577.046328282468, 6585.539012269287, 6618.0, 6620.66896655175, 6643.966780166068, 6305.8108256752375, 6457.903131453126, 6483.481321494363, 6484.027395890655, 6486.481081513373, 6327.11420401135, 6457.515686323451, 6466.773662921775, 6541.149650545399, 6554.737810487527, 6350.7777227796805, 6392.232932048184, 6397.808065758035, 6408.29508754046, 6437.485001199799], "yui.html": [691.1636919327614, 764.465795886636, 780.7033327335612, 783.4202690009395, 792.2829838995708, 13593.320333983298, 14133.78799318011, 14136.434542618283, 14167.079139855901, 14178.716425671493, 12506.0, 13021.869781302184, 13132.409041593128, 13143.737125257489, 13187.274699891503, 742.1576510660412, 930.6044930904372, 946.6970569417755, 955.469714308562, 955.5795450002012, 937.8593211018334, 944.36255527519, 945.9668911588096, 954.3367359685021, 954.766082309835, 798.66456088443, 803.3613277444446, 969.8399764038925, 988.2834944665132, 995.6863587969802, 969.4038166527605, 979.9657012004582, 980.8626792249091, 981.3768257156721, 981.9558119884587, 721.2895298131336, 724.8985142080113, 725.7387340557448, 726.1830440754152, 729.4711334282656, 14227.0, 14466.71066578673, 14497.637559061002, 14502.1298722077, 14531.564053078318, 11585.536578536932, 11861.881381186164, 12132.43367336753, 12157.331346775924, 12921.224726516439, 9526.476043817587, 9539.761505962337, 9858.309918305722, 10012.24908131893, 10187.694369168938, 3371.898843034713, 3401.0647072055135, 3516.5604299462566, 3523.9119022024397, 3525.995091398939, 44660.3300950486, 45530.31704524468, 49803.0, 50072.24891626628, 50073.0, 8983.101689830964, 9330.300227482965, 9391.530423478798, 9425.76435589102, 9566.186874115778, 19156.808431915782, 19180.520486987938, 19192.520186995436, 19237.422877313704, 20593.485162870747, 7020.227774944752, 7165.92834071663, 7385.926140738524, 7495.325420712162, 7508.2867127622785, 4172.645325147397, 4181.937270940938, 4236.894077648083, 4262.573742625775, 4273.850415235452, 3104.0, 3157.0528841347505, 3157.3369592385857, 3166.477531207325, 3183.029176101265, 455.45800497407976, 467.1031619290969, 468.9788959496831, 470.5388719055345, 470.80696914264985, 466.5357968820977, 472.98344557940305, 488.4748894937885, 490.8920037591724, 530.2920600997634, 7365.558066516026, 7469.365103966224, 7608.771736847903, 7934.894193145229, 8011.078725946474, 433.47549465147523, 497.21688340863284, 497.9701217926936, 511.35569182829903, 513.6327525819057, 3582.194006348551, 3985.3025720498795, 4072.775997320176, 4079.1637714268504, 4093.761957531783, 54143.72928135413, 54655.0, 54792.0, 54919.45080549223, 62905.37094628995, 47386.5261347389, 47740.52259477361, 48856.0, 51401.48598513967, 51747.48252517502, 47356.76321618439, 47504.0, 47835.0, 47836.760816195696, 47915.281270780964, 8102.351811855156, 8289.212524810133, 8405.117462666332, 8531.91468085336, 8601.82796344082, 34481.0, 34655.480167796995, 35366.64633353634, 35379.292414152085, 35509.82245088758, 43258.26966921288, 45321.0, 46899.53100468952, 47399.0, 47422.525774741815, 7801.4929029612895, 7889.447738658469, 8067.0722866871065, 8100.2304781045705, 8215.958920205361, 11137.387443690675, 11199.0, 11552.191346605658, 11721.12091593117, 11922.344271065174, 10520.842187367043, 10539.156867450432, 11039.116870650168, 11044.33733975964, 11338.659840204808, 10626.628068017582, 10943.45282735844, 11369.658910232707, 11442.48508817122, 11628.069754419796, 10113.19094472455, 10186.490675466346, 10390.740231494274, 10729.302595331279, 11178.88821111811, 8021.117677055636, 8486.40595158333, 8529.317654587494, 8802.163794439519, 9547.904520954702, 9223.400478968846, 9856.0, 9990.100890919852, 10030.247731420026, 10035.498225088862]}, "summary": {"suite": 6953.784068853092, "subtests": {"jquery.html": {"filtered": 7910.166921418234, "value": 7910.166921418234}, "dojo.html": {"filtered": 5564.575495775675, "value": 5564.575495775675}, "mootools.html": {"filtered": 4417.51410404773, "value": 4417.51410404773}, "ext.html": {"filtered": 19532.212445981077, "value": 19532.212445981077}, "prototype.html": {"filtered": 4842.956977043302, "value": 4842.956977043302}, "yui.html": {"filtered": 6146.536007560153, "value": 6146.536007560153}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0007"}, "testrun": {"date": 1447113681, "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": "20151109141834", "branch": "Mozilla-Aurora", "revision": "76ad230fa6ef4aac32718702aea593ef55976582"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 161.0, 161.0, 161.0, 159.0, 159.0, 161.0, 161.0, 161.0, 161.0], "ai-astar": [109.0, 110.0, 106.0, 108.0, 107.0, 109.0, 108.0, 110.0, 96.0, 107.0], "imaging-gaussian-blur": [121.0, 120.0, 114.0, 120.0, 120.0, 114.0, 120.0, 120.0, 120.0, 120.0], "audio-beat-detection": [154.0, 126.0, 148.0, 161.0, 126.0, 145.0, 127.0, 155.0, 146.0, 126.0], "json-stringify-tinderbox": [64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "stanford-crypto-pbkdf2": [146.0, 135.0, 144.0, 143.0, 148.0, 136.0, 145.0, 146.0, 144.0, 136.0], "json-parse-financial": [58.0, 62.0, 62.0, 62.0, 62.0, 63.0, 64.0, 71.0, 57.0, 56.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 71.0, 69.0, 68.0], "audio-fft": [77.0, 79.0, 115.0, 118.0, 65.0, 69.0, 70.0, 70.0, 119.0, 66.0], "imaging-darkroom": [124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0], "stanford-crypto-ccm": [121.0, 116.0, 120.0, 116.0, 126.0, 123.0, 119.0, 120.0, 131.0, 118.0], "audio-oscillator": [99.0, 97.0, 136.0, 88.0, 88.0, 92.0, 122.0, 87.0, 87.0, 125.0], "stanford-crypto-aes": [83.0, 81.0, 82.0, 82.0, 83.0, 82.0, 83.0, 82.0, 84.0, 87.0], "imaging-desaturate": [101.0, 99.0, 101.0, 100.0, 101.0, 100.0, 100.0, 100.0, 100.0, 100.0]}, "summary": {"suite": 1480.5, "subtests": {"audio-fft": {"filtered": 84.8, "value": 84.8}, "stanford-crypto-pbkdf2": {"filtered": 142.3, "value": 142.3}, "audio-beat-detection": {"filtered": 141.4, "value": 141.4}, "stanford-crypto-ccm": {"filtered": 121.0, "value": 121.0}, "imaging-darkroom": {"filtered": 124.0, "value": 124.0}, "json-parse-financial": {"filtered": 61.7, "value": 61.7}, "audio-oscillator": {"filtered": 102.1, "value": 102.1}, "ai-astar": {"filtered": 107.0, "value": 107.0}, "audio-dft": {"filtered": 160.5, "value": 160.5}, "stanford-crypto-sha256-iterative": {"filtered": 68.8, "value": 68.8}, "json-stringify-tinderbox": {"filtered": 64.9, "value": 64.9}, "imaging-gaussian-blur": {"filtered": 118.9, "value": 118.9}, "stanford-crypto-aes": {"filtered": 82.9, "value": 82.9}, "imaging-desaturate": {"filtered": 100.2, "value": 100.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0007"}, "testrun": {"date": 1447113681, "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": "20151109141834", "branch": "Mozilla-Aurora", "revision": "76ad230fa6ef4aac32718702aea593ef55976582"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.0219675262655], "Encrypt": [325.2032520325203], "NavierStokes": [5813.953488372093], "Decrypt": [5758.620689655172], "Splay": [589.9705014749262], "Richards": [165.92002654720426], "RegExp": [29200.0], "Earley": [675.219446320054], "Boyer": [12231.707317073171], "RayTrace": [1009.0817356205853]}, "summary": {"suite": 20425.251216236218, "subtests": {"DeltaBlue": {"filtered": 346.12773000000004, "value": 346.12773000000004}, "Encrypt": {"filtered": 818.506575, "value": 818.506575}, "NavierStokes": {"filtered": 255.24799999999982, "value": 255.24799999999982}, "Decrypt": {"filtered": 46.22304790419163, "value": 46.22304790419163}, "Splay": {"filtered": 138.12724499999996, "value": 138.12724499999996}, "RegExp": {"filtered": 31.19811643835619, "value": 31.19811643835619}, "Richards": {"filtered": 212.765154, "value": 212.765154}, "Earley": {"filtered": 987.0317029999998, "value": 987.0317029999998}, "Boyer": {"filtered": 54.4865064805583, "value": 54.4865064805583}, "RayTrace": {"filtered": 733.3290990000002, "value": 733.3290990000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0007"}, "testrun": {"date": 1447113681, "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": "20151109141834", "branch": "Mozilla-Aurora", "revision": "76ad230fa6ef4aac32718702aea593ef55976582"}}] 16:21:29 INFO - RETURN: dromaeo_css: 6953.79 16:21:29 INFO - RETURN: kraken: 1480.50 16:21:29 INFO - RETURN: v8_7: 20425.25 16:21:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20425.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1480.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6953.79"}}} 16:21:29 INFO - Return code: 0 16:21:29 INFO - # TBPL SUCCESS # 16:21:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:21:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:21:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:21:29 INFO - 2015-11-09 16:21:29.315 screenresolution[1664:10261] starting screenresolution argv=screenresolution get 16:21:29 INFO - 2015-11-09 16:21:29.318 screenresolution[1664:10261] Display 0: 1600x1200x32@60 16:21:29 INFO - 2015-11-09 16:21:29.324 screenresolution[1665:10264] starting screenresolution argv=screenresolution list 16:21:29 INFO - Available Modes on Display 0 16:21:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:21:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:21:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:21:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:21:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:21:29 INFO - Intel HD Graphics 3000: 16:21:29 INFO - Chipset Model: Intel HD Graphics 3000 16:21:29 INFO - Type: GPU 16:21:29 INFO - Bus: Built-In 16:21:29 INFO - VRAM (Total): 512 MB 16:21:29 INFO - VRAM (Dynamic, Max): 10 16:21:29 INFO - Vendor: Intel (0x8086) 16:21:29 INFO - Device ID: 0x0116 16:21:29 INFO - Revision ID: 0x0009 16:21:29 INFO - Displays: 16:21:29 INFO - Display: 16:21:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:21:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:21:29 INFO - Display Serial Number: 1600x1200 60 16:21:29 INFO - Main Display: Yes 16:21:29 INFO - Mirror: Off 16:21:29 INFO - Online: Yes 16:21:29 INFO - Rotation: Supported 16:21:29 INFO - Return code: 0 16:21:29 INFO - Running post-action listener: _resource_record_post_action 16:21:29 INFO - Running post-run listener: _resource_record_post_run 16:21:30 INFO - Total resource usage - Wall time: 1246s; CPU: 30.0%; Read bytes: 40260608; Write bytes: 686205952; Read time: 8238; Write time: 49015 16:21:30 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 333783552; Write bytes: 332826624; Read time: 32371; Write time: 5253 16:21:30 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 39171072; Write bytes: 340532224; Read time: 7191; Write time: 39679 16:21:30 INFO - Running post-run listener: _upload_blobber_files 16:21:30 INFO - Blob upload gear active. 16:21:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:21:30 INFO - Copying logs to upload dir... 16:21:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.969606 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-09 16:21:30.807065) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:21:30.812106) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010004 build_url: 'https://queue.taskcluster.net/v1/task/NwUdUwr-RBuu4wJPgQjVeQ/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.41 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:21:31.227127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:21:31.227563) ========= 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.P8CjZV0DLt/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.PLUO4QDEft/Listeners TMPDIR=/var/folders/kj/7327ynl53zvdj68s0gd_3ss800000w/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.005277 ========= master_lag: 0.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:21:31.819670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 16:21:31.820016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 16:21:31.820413) ========= ========= Total master_lag: 5.35 =========