builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0101 starttime: 1449182438.0 results: success (0) buildid: 20151203130049 builduid: 9fe996d24cd643ec808a41ac95a4dc61 revision: 7303f043cf7e4ebd20ce072d33ed4a92495f503f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.000470) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.000941) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.001286) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005512 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.032006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.032353) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.057189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.057827) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.016056 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.110765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.111405) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.112259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.112865) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-12-03 14:40:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.03G=0s 2015-12-03 14:40:38 (1.03 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142361 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.270309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.270919) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.111023 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.393910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.394415) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7303f043cf7e4ebd20ce072d33ed4a92495f503f --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 7303f043cf7e4ebd20ce072d33ed4a92495f503f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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-12-03 14:40:38,484 truncating revision to first 12 chars 2015-12-03 14:40:38,484 Setting DEBUG logging. 2015-12-03 14:40:38,484 attempt 1/10 2015-12-03 14:40:38,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7303f043cf7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 14:40:38,768 unpacking tar archive at: mozilla-aurora-7303f043cf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564871 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.972735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.973110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.981914) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.982246) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 14:40:38.982679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-12-03 14:40:38.983010) ========= /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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:40:39 INFO - MultiFileLogger online at 20151203 14:40:39 in /builds/slave/test 14:40:39 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 14:40:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:40:39 INFO - {'append_to_log': False, 14:40:39 INFO - 'base_work_dir': '/builds/slave/test', 14:40:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:40:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:40:39 INFO - 'branch': 'Mozilla-Aurora', 14:40:39 INFO - 'buildbot_json_path': 'buildprops.json', 14:40:39 INFO - 'config_files': ('talos/mac_config.py',), 14:40:39 INFO - 'default_actions': ('clobber', 14:40:39 INFO - 'read-buildbot-config', 14:40:39 INFO - 'download-and-extract', 14:40:39 INFO - 'populate-webroot', 14:40:39 INFO - 'create-virtualenv', 14:40:39 INFO - 'install', 14:40:39 INFO - 'run-tests'), 14:40:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:40:39 INFO - 'download_minidump_stackwalk': True, 14:40:39 INFO - 'download_symbols': 'ondemand', 14:40:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:40:39 INFO - 'tooltool.py': '/tools/tooltool.py', 14:40:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:40:39 INFO - '/tools/misc-python/virtualenv.py')}, 14:40:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:40:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:40:39 INFO - 'installer_path': 'installer.exe', 14:40:39 INFO - 'log_level': 'info', 14:40:39 INFO - 'log_name': 'talos', 14:40:39 INFO - 'log_to_console': True, 14:40:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:40:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:40:39 INFO - 'opt_config_files': (), 14:40:39 INFO - 'pip_index': False, 14:40:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:40:39 INFO - 'cmd': ('bash', 14:40:39 INFO - '-c', 14:40:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:40:39 INFO - 'enabled': True, 14:40:39 INFO - 'halt_on_failure': False, 14:40:39 INFO - 'name': 'check_screen_resolution'},), 14:40:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:40:39 INFO - 'cmd': ('bash', 14:40:39 INFO - '-c', 14:40:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:40:39 INFO - 'enabled': True, 14:40:39 INFO - 'halt_on_failure': False, 14:40:39 INFO - 'name': 'check_screen_resolution'},), 14:40:39 INFO - 'run_cmd_checks_enabled': True, 14:40:39 INFO - 'sps_profile': False, 14:40:39 INFO - 'sps_profile_interval': 0, 14:40:39 INFO - 'suite': 'dromaeojs', 14:40:39 INFO - 'system_bits': '64', 14:40:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:40:39 INFO - 'title': 't-yosemite-r5-0101', 14:40:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:40:39 INFO - 'use_talos_json': True, 14:40:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:40:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:40:39 INFO - 'work_dir': 'build'} 14:40:39 INFO - ##### 14:40:39 INFO - ##### Running clobber step. 14:40:39 INFO - ##### 14:40:39 INFO - Running pre-action listener: _resource_record_pre_action 14:40:39 INFO - Running main action method: clobber 14:40:39 INFO - rmtree: /builds/slave/test/build 14:40:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:40:43 INFO - Running post-action listener: _resource_record_post_action 14:40:43 INFO - ##### 14:40:43 INFO - ##### Running read-buildbot-config step. 14:40:43 INFO - ##### 14:40:43 INFO - Running pre-action listener: _resource_record_pre_action 14:40:43 INFO - Running main action method: read_buildbot_config 14:40:43 INFO - Using buildbot properties: 14:40:43 INFO - { 14:40:43 INFO - "properties": { 14:40:43 INFO - "buildnumber": 293, 14:40:43 INFO - "product": "firefox", 14:40:43 INFO - "script_repo_revision": "production", 14:40:43 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 14:40:43 INFO - "repository": "", 14:40:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 14:40:43 INFO - "buildid": "20151203130049", 14:40:43 INFO - "slavename": "t-yosemite-r5-0101", 14:40:43 INFO - "pgo_build": "False", 14:40:43 INFO - "basedir": "/builds/slave/test", 14:40:43 INFO - "project": "", 14:40:43 INFO - "platform": "yosemite", 14:40:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:40:43 INFO - "slavebuilddir": "test", 14:40:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:40:43 INFO - "branch": "mozilla-aurora", 14:40:43 INFO - "repo_path": "releases/mozilla-aurora", 14:40:43 INFO - "stage_platform": "macosx64", 14:40:43 INFO - "builduid": "9fe996d24cd643ec808a41ac95a4dc61", 14:40:43 INFO - "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f" 14:40:43 INFO - }, 14:40:43 INFO - "sourcestamp": { 14:40:43 INFO - "repository": "", 14:40:43 INFO - "hasPatch": false, 14:40:43 INFO - "project": "", 14:40:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:40:43 INFO - "changes": [ 14:40:43 INFO - { 14:40:43 INFO - "category": null, 14:40:43 INFO - "files": [ 14:40:43 INFO - { 14:40:43 INFO - "url": null, 14:40:43 INFO - "name": "https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 14:40:43 INFO - } 14:40:43 INFO - ], 14:40:43 INFO - "repository": "", 14:40:43 INFO - "rev": "7303f043cf7e4ebd20ce072d33ed4a92495f503f", 14:40:43 INFO - "who": "bgrinstead@mozilla.com", 14:40:43 INFO - "when": 1449181144, 14:40:43 INFO - "number": 6741087, 14:40:43 INFO - "comments": "Bug 1220011 - Yield on 'console close' command in test (fixes permafail with bug 1224294 applied); r=jwalker, a=testonly", 14:40:43 INFO - "project": "", 14:40:43 INFO - "at": "Thu 03 Dec 2015 14:19:04", 14:40:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 14:40:43 INFO - "revlink": "", 14:40:43 INFO - "properties": [ 14:40:43 INFO - [ 14:40:43 INFO - "buildid", 14:40:43 INFO - "20151203130049", 14:40:43 INFO - "Change" 14:40:43 INFO - ], 14:40:43 INFO - [ 14:40:43 INFO - "builduid", 14:40:43 INFO - "9fe996d24cd643ec808a41ac95a4dc61", 14:40:43 INFO - "Change" 14:40:43 INFO - ], 14:40:43 INFO - [ 14:40:43 INFO - "pgo_build", 14:40:43 INFO - "False", 14:40:43 INFO - "Change" 14:40:43 INFO - ] 14:40:43 INFO - ], 14:40:43 INFO - "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f" 14:40:43 INFO - } 14:40:43 INFO - ], 14:40:43 INFO - "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f" 14:40:43 INFO - } 14:40:43 INFO - } 14:40:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 14:40:43 INFO - Running post-action listener: _resource_record_post_action 14:40:43 INFO - ##### 14:40:43 INFO - ##### Running download-and-extract step. 14:40:43 INFO - ##### 14:40:43 INFO - Running pre-action listener: _resource_record_pre_action 14:40:43 INFO - Running main action method: download_and_extract 14:40:43 INFO - mkdir: /builds/slave/test/build/tests 14:40:43 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')]} 14:40:43 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/test_packages.json 14:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/test_packages.json 14:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:40:43 INFO - Downloaded 1149 bytes. 14:40:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:40:43 INFO - Using the following test package requirements: 14:40:43 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:40:43 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 14:40:43 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'jsshell-mac.zip'], 14:40:43 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 14:40:43 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:40:43 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 14:40:43 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 14:40:43 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 14:40:43 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 14:40:43 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 14:40:43 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 14:40:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:40:43 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')]} 14:40:43 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:40:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:40:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:40:44 INFO - Downloaded 17490053 bytes. 14:40:44 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 14:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:40:51 INFO - Return code: 0 14:40:51 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 14:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:51 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:40:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:40:52 INFO - Downloaded 17490053 bytes. 14:40:52 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 14:40:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 14:40:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 14:41:00 INFO - Return code: 0 14:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:00 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:41:01 INFO - Downloaded 11131307 bytes. 14:41:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 14:41:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 14:41:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:41:01 INFO - Return code: 0 14:41:01 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')]} 14:41:01 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 14:41:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:41:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:41:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 14:41:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:41:05 INFO - Downloaded 108688943 bytes. 14:41:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:41:05 INFO - mkdir: /builds/slave/test/properties 14:41:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:41:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:41:05 INFO - Contents: 14:41:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 14:41:05 INFO - Running post-action listener: _resource_record_post_action 14:41:05 INFO - Running post-action listener: set_extra_try_arguments 14:41:05 INFO - ##### 14:41:05 INFO - ##### Running populate-webroot step. 14:41:05 INFO - ##### 14:41:05 INFO - Running pre-action listener: _resource_record_pre_action 14:41:05 INFO - Running main action method: populate_webroot 14:41:05 INFO - Guessing talos json url... 14:41: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')]} 14:41:05 INFO - https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 14:41:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:41:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 14:41:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/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 14:41:06 INFO - Downloaded 107 bytes. 14:41:06 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 14:41:06 INFO - Contents: 14:41:06 INFO - 20151203130049 14:41:06 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/7303f043cf7e4ebd20ce072d33ed4a92495f503f 14:41: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')]} 14:41:06 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7303f043cf/testing/talos/talos.json 14:41:06 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7303f043cf/testing/talos/talos.json to /builds/slave/test/build/talos.json 14:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/7303f043cf/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 14:41:06 INFO - Downloaded 4264 bytes. 14:41:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:41:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:41:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:41:06 INFO - '../fennec_ids.txt'], 14:41:06 INFO - 'tests': ['tcheck2']}, 14:41:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:41:06 INFO - '--tppagecycles', 14:41:06 INFO - '7'], 14:41:06 INFO - 'tests': ['tsvgm']}}, 14:41:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:41:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:41:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:41:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:41:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:41:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'tests': ['damp', 'tps']}, 14:41:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['damp', 'tps']}, 14:41:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:41:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:41:06 INFO - 'other': {'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'other_l64': {'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'other_nol64': {'tests': ['a11yr', 14:41:06 INFO - 'ts_paint', 14:41:06 INFO - 'tpaint', 14:41:06 INFO - 'sessionrestore', 14:41:06 INFO - 'sessionrestore_no_auto_restore']}, 14:41:06 INFO - 'svgr': {'tests': ['tsvgx', 14:41:06 INFO - 'tsvgr_opacity', 14:41:06 INFO - 'tart', 14:41:06 INFO - 'tscrollx', 14:41:06 INFO - 'cart']}, 14:41:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['tsvgx', 14:41:06 INFO - 'tsvgr_opacity', 14:41:06 INFO - 'tart', 14:41:06 INFO - 'tscrollx', 14:41:06 INFO - 'cart']}, 14:41:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'tests': ['tp5o']}, 14:41:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'talos_options': ['--e10s'], 14:41:06 INFO - 'tests': ['tp5o']}, 14:41:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'talos_options': ['--xperf_path', 14:41:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:41:06 INFO - 'tests': ['tp5n']}, 14:41:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:41:06 INFO - 'talos_options': ['--e10s', 14:41:06 INFO - '--xperf_path', 14:41:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 14:41:06 INFO - 'C:/slave/talos-data/talos/xperf.config'], 14:41:06 INFO - 'tests': ['tp5n']}}, 14:41:06 INFO - 'talos.zip': {'path': '', 14:41:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:41:06 INFO - Running post-action listener: _resource_record_post_action 14:41:06 INFO - ##### 14:41:06 INFO - ##### Running create-virtualenv step. 14:41:06 INFO - ##### 14:41:06 INFO - Running pre-action listener: _resource_record_pre_action 14:41:06 INFO - Running main action method: create_virtualenv 14:41:06 INFO - Creating virtualenv /builds/slave/test/build/venv 14:41:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:41:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:41:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:41:06 INFO - Using real prefix '/tools/python27' 14:41:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:41:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:41:12 INFO - Installing pip.................done. 14:41:12 INFO - Return code: 0 14:41:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:12 INFO - 'HOME': '/Users/cltbld', 14:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:12 INFO - 'LOGNAME': 'cltbld', 14:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:12 INFO - 'MOZ_NO_REMOTE': '1', 14:41:12 INFO - 'NO_EM_RESTART': '1', 14:41:12 INFO - 'PAGER': '/bin/cat', 14:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:12 INFO - 'PWD': '/builds/slave/test', 14:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:12 INFO - 'SHELL': '/bin/bash', 14:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:12 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:12 INFO - 'USER': 'cltbld', 14:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:12 INFO - 'XPC_FLAGS': '0x0', 14:41:12 INFO - 'XPC_SERVICE_NAME': '0', 14:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:13 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 14:41:13 INFO - Cleaning up... 14:41:13 INFO - Return code: 0 14:41:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:41:13 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')]} 14:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 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')]} 14:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:13 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 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:13 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 14:41:13 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 14:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:13 INFO - 'HOME': '/Users/cltbld', 14:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:13 INFO - 'LOGNAME': 'cltbld', 14:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:13 INFO - 'MOZ_NO_REMOTE': '1', 14:41:13 INFO - 'NO_EM_RESTART': '1', 14:41:13 INFO - 'PAGER': '/bin/cat', 14:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:13 INFO - 'PWD': '/builds/slave/test', 14:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:13 INFO - 'SHELL': '/bin/bash', 14:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:13 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:13 INFO - 'USER': 'cltbld', 14:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:13 INFO - 'XPC_FLAGS': '0x0', 14:41:13 INFO - 'XPC_SERVICE_NAME': '0', 14:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:13 INFO - Downloading/unpacking psutil>=0.7.1 14:41:13 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 14:41:13 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 14:41:13 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 14:41:13 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 14:41:13 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 14:41:13 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 14:41:16 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:41:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:41:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:16 INFO - Installing collected packages: psutil 14:41:16 INFO - Running setup.py install for psutil 14:41:16 INFO - building 'psutil._psutil_osx' extension 14:41:16 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 14:41:18 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 14:41:18 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 14:41:19 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 14:41:19 INFO - building 'psutil._psutil_posix' extension 14:41:19 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 14:41:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:41:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:41:19 INFO - ^ 14:41:19 INFO - 1 warning generated. 14:41:19 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 14:41:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:41:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:41:19 INFO - Successfully installed psutil 14:41:19 INFO - Cleaning up... 14:41:19 INFO - Return code: 0 14:41:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:19 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 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:19 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 14:41:19 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 14:41:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:19 INFO - 'HOME': '/Users/cltbld', 14:41:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:19 INFO - 'LOGNAME': 'cltbld', 14:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:19 INFO - 'MOZ_NO_REMOTE': '1', 14:41:19 INFO - 'NO_EM_RESTART': '1', 14:41:19 INFO - 'PAGER': '/bin/cat', 14:41:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:19 INFO - 'PWD': '/builds/slave/test', 14:41:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:19 INFO - 'SHELL': '/bin/bash', 14:41:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:19 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:19 INFO - 'USER': 'cltbld', 14:41:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:19 INFO - 'XPC_FLAGS': '0x0', 14:41:19 INFO - 'XPC_SERVICE_NAME': '0', 14:41:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:41:20 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 14:41:20 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 14:41:20 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 14:41:20 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 14:41:20 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 14:41:20 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 14:41:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:41:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:41:22 INFO - Installing collected packages: mozsystemmonitor 14:41:22 INFO - Running setup.py install for mozsystemmonitor 14:41:23 INFO - Successfully installed mozsystemmonitor 14:41:23 INFO - Cleaning up... 14:41:23 INFO - Return code: 0 14:41:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:41: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')]} 14:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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')]} 14:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41: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', '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 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:41: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 blobuploader==1.2.4 14:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:23 INFO - 'HOME': '/Users/cltbld', 14:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:23 INFO - 'LOGNAME': 'cltbld', 14:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:23 INFO - 'MOZ_NO_REMOTE': '1', 14:41:23 INFO - 'NO_EM_RESTART': '1', 14:41:23 INFO - 'PAGER': '/bin/cat', 14:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:23 INFO - 'PWD': '/builds/slave/test', 14:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:23 INFO - 'SHELL': '/bin/bash', 14:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:23 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:23 INFO - 'USER': 'cltbld', 14:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:23 INFO - 'XPC_FLAGS': '0x0', 14:41:23 INFO - 'XPC_SERVICE_NAME': '0', 14:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:41:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:41:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41: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 14:41:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:41:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:27 INFO - Downloading docopt-0.6.1.tar.gz 14:41:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:41:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:41:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:41:27 INFO - Running setup.py install for blobuploader 14:41:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:41:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:41:28 INFO - Running setup.py install for requests 14:41:28 INFO - Running setup.py install for docopt 14:41:28 INFO - Successfully installed blobuploader requests docopt 14:41:28 INFO - Cleaning up... 14:41:29 INFO - Return code: 0 14:41:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:29 INFO - 'HOME': '/Users/cltbld', 14:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:29 INFO - 'LOGNAME': 'cltbld', 14:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:29 INFO - 'MOZ_NO_REMOTE': '1', 14:41:29 INFO - 'NO_EM_RESTART': '1', 14:41:29 INFO - 'PAGER': '/bin/cat', 14:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:29 INFO - 'PWD': '/builds/slave/test', 14:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:29 INFO - 'SHELL': '/bin/bash', 14:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:29 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:29 INFO - 'USER': 'cltbld', 14:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:29 INFO - 'XPC_FLAGS': '0x0', 14:41:29 INFO - 'XPC_SERVICE_NAME': '0', 14:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-izh4dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-AHeaux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-DnrF08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ZL8Lwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:29 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-yJpxZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-jwQXOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-HHYncS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-btWyIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-oWrJFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-8Jqp26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-8WZoVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:30 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-35ZMPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-cjQuGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Y_4X5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-YxII05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-CcMOEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:31 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-MSc8nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:41:31 INFO - Running setup.py install for manifestparser 14:41:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:41:31 INFO - Running setup.py install for mozcrash 14:41:32 INFO - Running setup.py install for mozdebug 14:41:32 INFO - Running setup.py install for mozdevice 14:41:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozfile 14:41:32 INFO - Running setup.py install for mozhttpd 14:41:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:41:32 INFO - Running setup.py install for mozinfo 14:41:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozInstall 14:41:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozleak 14:41:33 INFO - Running setup.py install for mozlog 14:41:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for moznetwork 14:41:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:41:33 INFO - Running setup.py install for mozprocess 14:41:34 INFO - Running setup.py install for mozprofile 14:41:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:41:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:41:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:41:34 INFO - Running setup.py install for mozrunner 14:41:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:41:34 INFO - Running setup.py install for mozscreenshot 14:41:34 INFO - Running setup.py install for moztest 14:41:34 INFO - Running setup.py install for mozversion 14:41:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:41:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:41:35 INFO - Cleaning up... 14:41:35 INFO - Return code: 0 14:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:41:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:35 INFO - 'HOME': '/Users/cltbld', 14:41:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:35 INFO - 'LOGNAME': 'cltbld', 14:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:35 INFO - 'MOZ_NO_REMOTE': '1', 14:41:35 INFO - 'NO_EM_RESTART': '1', 14:41:35 INFO - 'PAGER': '/bin/cat', 14:41:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:35 INFO - 'PWD': '/builds/slave/test', 14:41:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:35 INFO - 'SHELL': '/bin/bash', 14:41:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:35 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:35 INFO - 'USER': 'cltbld', 14:41:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:35 INFO - 'XPC_FLAGS': '0x0', 14:41:35 INFO - 'XPC_SERVICE_NAME': '0', 14:41:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:41:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-hwZcZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:41:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Ko79KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:41:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-AKNcIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:41:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:41:35 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-wXyOh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ysLzb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:41:36 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)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-es4g_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-7LReKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-gTPGQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-FLLEL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-7t3amm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:41:36 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Ie6gDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:41:37 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)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Dd8u0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:41:37 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)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-3r0pD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:41:37 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)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-5BWmut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-DsRsxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-YWapbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:41:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:41:37 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-7WVZKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:41:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:41:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:41:40 INFO - Downloading blessings-1.5.1.tar.gz 14:41:40 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 14:41:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:41:40 INFO - Installing collected packages: blessings 14:41:40 INFO - Running setup.py install for blessings 14:41:41 INFO - Successfully installed blessings 14:41:41 INFO - Cleaning up... 14:41:41 INFO - Return code: 0 14:41:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:41 INFO - Reading from file tmpfile_stdout 14:41:41 INFO - Current package versions: 14:41:41 INFO - blessings == 1.5.1 14:41:41 INFO - blobuploader == 1.2.4 14:41:41 INFO - docopt == 0.6.1 14:41:41 INFO - manifestparser == 1.1 14:41:41 INFO - mozInstall == 1.12 14:41:41 INFO - mozcrash == 0.16 14:41:41 INFO - mozdebug == 0.1 14:41:41 INFO - mozdevice == 0.46 14:41:41 INFO - mozfile == 1.2 14:41:41 INFO - mozhttpd == 0.7 14:41:41 INFO - mozinfo == 0.8 14:41:41 INFO - mozleak == 0.1 14:41:41 INFO - mozlog == 3.0 14:41:41 INFO - moznetwork == 0.27 14:41:41 INFO - mozprocess == 0.22 14:41:41 INFO - mozprofile == 0.27 14:41:41 INFO - mozrunner == 6.11 14:41:41 INFO - mozscreenshot == 0.1 14:41:41 INFO - mozsystemmonitor == 0.0 14:41:41 INFO - moztest == 0.7 14:41:41 INFO - mozversion == 1.4 14:41:41 INFO - psutil == 3.1.1 14:41:41 INFO - requests == 1.2.3 14:41:41 INFO - wsgiref == 0.1.2 14:41:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:41:41 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 0x103ad9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b46228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c23602fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, '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.iAxEt6H70B/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.soSherLr07/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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 14:41:41 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 14:41:41 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 14:41:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:41:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:41:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:41:41 INFO - 'HOME': '/Users/cltbld', 14:41:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:41:41 INFO - 'LOGNAME': 'cltbld', 14:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:41:41 INFO - 'MOZ_NO_REMOTE': '1', 14:41:41 INFO - 'NO_EM_RESTART': '1', 14:41:41 INFO - 'PAGER': '/bin/cat', 14:41:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:41:41 INFO - 'PWD': '/builds/slave/test', 14:41:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:41:41 INFO - 'SHELL': '/bin/bash', 14:41:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:41:41 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:41:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:41:41 INFO - 'USER': 'cltbld', 14:41:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:41:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:41:41 INFO - 'XPC_FLAGS': '0x0', 14:41:41 INFO - 'XPC_SERVICE_NAME': '0', 14:41:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 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)) 14:41:41 INFO - Cleaning up... 14:41:41 INFO - Return code: 0 14:41:41 INFO - Running post-action listener: _resource_record_post_action 14:41:41 INFO - Running post-action listener: _start_resource_monitoring 14:41:42 INFO - Starting resource monitoring. 14:41:42 INFO - ##### 14:41:42 INFO - ##### Running install step. 14:41:42 INFO - ##### 14:41:42 INFO - Running pre-action listener: _resource_record_pre_action 14:41:42 INFO - Running main action method: install 14:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:41:42 INFO - Reading from file tmpfile_stdout 14:41:42 INFO - Detecting whether we're running mozinstall >=1.0... 14:41:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:41:42 INFO - Reading from file tmpfile_stdout 14:41:42 INFO - Output received: 14:41:42 INFO - Usage: mozinstall [options] installer 14:41:42 INFO - Options: 14:41:42 INFO - -h, --help show this help message and exit 14:41:42 INFO - -d DEST, --destination=DEST 14:41:42 INFO - Directory to install application into. [default: 14:41:42 INFO - "/builds/slave/test"] 14:41:42 INFO - --app=APP Application being installed. [default: firefox] 14:41:42 INFO - mkdir: /builds/slave/test/build/application 14:41:42 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'] 14:41:42 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 14:42:24 INFO - Reading from file tmpfile_stdout 14:42:24 INFO - Output received: 14:42:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:42:24 INFO - Running post-action listener: _resource_record_post_action 14:42:24 INFO - ##### 14:42:24 INFO - ##### Running run-tests step. 14:42:24 INFO - ##### 14:42:24 INFO - Running pre-action listener: _resource_record_pre_action 14:42:24 INFO - Running main action method: run_tests 14:42:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:42:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:42:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:42:24 INFO - 2015-12-03 14:42:24.934 screenresolution[1628:7607] starting screenresolution argv=screenresolution get 14:42:24 INFO - 2015-12-03 14:42:24.938 screenresolution[1628:7607] Display 0: 1600x1200x32@60 14:42:24 INFO - 2015-12-03 14:42:24.945 screenresolution[1629:7609] starting screenresolution argv=screenresolution list 14:42:24 INFO - Available Modes on Display 0 14:42:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:42:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:42:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:42:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:42:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:42:25 INFO - Intel HD Graphics 3000: 14:42:25 INFO - Chipset Model: Intel HD Graphics 3000 14:42:25 INFO - Type: GPU 14:42:25 INFO - Bus: Built-In 14:42:25 INFO - VRAM (Total): 512 MB 14:42:25 INFO - VRAM (Dynamic, Max): 10 14:42:25 INFO - Vendor: Intel (0x8086) 14:42:25 INFO - Device ID: 0x0116 14:42:25 INFO - Revision ID: 0x0009 14:42:25 INFO - Displays: 14:42:25 INFO - Display: 14:42:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:42:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:42:25 INFO - Display Serial Number: 1600x1200 60 14:42:25 INFO - Main Display: Yes 14:42:25 INFO - Mirror: Off 14:42:25 INFO - Online: Yes 14:42:25 INFO - Rotation: Supported 14:42:25 INFO - Return code: 0 14:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:42:25 INFO - Python 2.7.3 14:42:25 INFO - Return code: 0 14:42:25 INFO - grabbing minidump binary from tooltool 14:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:25 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 0x103a8e9f0>, '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 0x1037edcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a58990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:42:25 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 14:42:25 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 14:42:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:42:25 INFO - Return code: 0 14:42:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:42:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:42:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:42:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:42:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:42:25 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/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] in /builds/slave/test/build 14:42:25 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/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0101 --webServer localhost 14:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAxEt6H70B/Render', 14:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:42:25 INFO - 'HOME': '/Users/cltbld', 14:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:42:25 INFO - 'LOGNAME': 'cltbld', 14:42:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:42:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:42:25 INFO - 'MOZ_NO_REMOTE': '1', 14:42:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:42:25 INFO - 'NO_EM_RESTART': '1', 14:42:25 INFO - 'PAGER': '/bin/cat', 14:42:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:42:25 INFO - 'PWD': '/builds/slave/test', 14:42:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:42:25 INFO - 'SHELL': '/bin/bash', 14:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.soSherLr07/Listeners', 14:42:25 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 14:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:42:25 INFO - 'USER': 'cltbld', 14:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:42:25 INFO - 'XPC_FLAGS': '0x0', 14:42:25 INFO - 'XPC_SERVICE_NAME': '0', 14:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:42:25 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/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] with output_timeout 3600 14:42:25 INFO - mozversion INFO | application_buildid: 20151203130049 14:42:25 INFO - mozversion INFO | application_changeset: 7303f043cf7e4ebd20ce072d33ed4a92495f503f 14:42:25 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:42:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:42:25 INFO - mozversion INFO | application_name: Firefox 14:42:25 INFO - mozversion INFO | application_remotingname: firefox-dev 14:42:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:42:25 INFO - mozversion INFO | application_vendor: Mozilla 14:42:25 INFO - mozversion INFO | application_version: 44.0a2 14:42:25 INFO - mozversion INFO | platform_buildid: 20151203130049 14:42:25 INFO - mozversion INFO | platform_changeset: 7303f043cf7e4ebd20ce072d33ed4a92495f503f 14:42:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:42:25 INFO - mozversion INFO | platform_version: 44.0a2 14:42:25 INFO - 2015-12-03 14:42:25,694 DEBUG : using testdate: 1449182545 14:42:25 INFO - 2015-12-03 14:42:25,694 DEBUG : actual date: 1449182545 14:42:25 INFO - 2015-12-03 14:42:25,750 INFO : starting webserver on 'localhost:49271' 14:42:25 INFO - 2015-12-03 14:42:25,751 INFO : Starting test suite t-yosemite-r5-0101 14:42:25 INFO - 2015-12-03 14:42:25,751 INFO : Starting test dromaeo_css 14:42:25 INFO - 2015-12-03 14:42:25,751 DEBUG : operating with platform_type : mac_ 14:42:25 INFO - 2015-12-03 14:42:25,752 INFO : Initialising browser for dromaeo_css test... 14:42:25 INFO - 2015-12-03 14:42:25,776 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpbL2vrP/profile http://localhost:49271/getInfo.html 14:42:28 INFO - 2015-12-03 14:42:28,815 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:42:28 INFO - 2015-12-03 14:42:28,816 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:42:28 INFO - 2015-12-03 14:42:28,816 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:42:28 INFO - 2015-12-03 14:42:28,816 DEBUG : BROWSER_OUTPUT: __metrics 14:42:28 INFO - 2015-12-03 14:42:28,831 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:29 INFO - 2015-12-03 14:42:29,577 INFO : Browser initialized. 14:42:29 INFO - 2015-12-03 14:42:29,577 INFO : Running cycle 1/1 for dromaeo_css test... 14:42:29 INFO - 2015-12-03 14:42:29,578 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpbL2vrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:42:41 INFO - 2015-12-03 14:42:41,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 197570560 14:42:41 INFO - 2015-12-03 14:42:41,583 DEBUG : BROWSER_OUTPUT: 14:43:33 INFO - 2015-12-03 14:43:33,068 DEBUG : BROWSER_OUTPUT: 1449182613064 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] 14:45:43 INFO - 2015-12-03 14:45:43,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 14:45:44 INFO - 2015-12-03 14:45:44,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 310833152 14:45:44 INFO - 2015-12-03 14:45:44,792 DEBUG : BROWSER_OUTPUT: 14:48:47 INFO - 2015-12-03 14:48:47,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 14:48:48 INFO - 2015-12-03 14:48:48,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 341749760 14:48:48 INFO - 2015-12-03 14:48:48,209 DEBUG : BROWSER_OUTPUT: 14:51:50 INFO - 2015-12-03 14:51:50,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:51:51 INFO - 2015-12-03 14:51:51,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 308461568 14:51:51 INFO - 2015-12-03 14:51:51,281 DEBUG : BROWSER_OUTPUT: 14:54:53 INFO - 2015-12-03 14:54:53,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:54:53 INFO - 2015-12-03 14:54:53,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 299012096 14:54:53 INFO - 2015-12-03 14:54:53,978 DEBUG : BROWSER_OUTPUT: 14:57:57 INFO - 2015-12-03 14:57:57,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 14:57:57 INFO - 2015-12-03 14:57:57,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 298496000 14:57:57 INFO - 2015-12-03 14:57:57,998 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 15:01:00 INFO - 2015-12-03 15:01:00,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 344477696 15:01:00 INFO - 2015-12-03 15:01:00,893 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,893 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:01:00 INFO - 2015-12-03 15:01:00,893 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:01:00 INFO - 2015-12-03 15:01:00,894 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:01:00 INFO - 2015-12-03 15:01:00,894 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:01:00 INFO - 2015-12-03 15:01:00,894 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2602.2843717977553;2664.8134630575855;2667.1998400479865;2671.9866400667993;2700.203439985204;4561.657875659326;4564.338170965208;4577.038821847416;4592.701474404162;4662.184117779392;4584.404027476432;4589.265717485203;4596.0578081493295;4623.4451865776155;4653.232216684251;4179.101493178973;4214.515330736958;4233.174530966463;4271.252530807112;4317.438732964726;4058.6347228749405;4066.2883995300854;4086.346184610448;4104.179164167179;4105;3807.8286477108595;4045.887380970242;4058.391241313797;4097.9180416391655;4113.300738874398;4097.282975479294;4134.400511925754;4209.957900420987;4241.427407300006;4254.276772948575;4163.812628431728;4202.3696445533105;4211.663066954667;4241.151769646083;4259.063006138645;4301.65586753059;4514.367988481616;4536.296873984537;4585.862424127282;4589.288660257632;4684.414448193976;4782.521747825224;4792.832250871203;4822.059698358821;4838.661293709441;4838.661293709441;4863.683860549053;4879.56083952446;4880.999395124027;4920.4833492483485;4406.62543683784;4548.044910568785;4560.110778398213;4566.589006989387;4577.5880170784785;4947.406311242602;4956.207006878882;4992.625553083533;5087.694738315713;5090.6691065081395;4811.3745213122775;4855.732934688626;4869.211074011373;4878.95121048792;4911.9754401227765;4648.767561621906;5013.799448022111;5027.899442011139;5029.195328747456;5030.195168772979;4581.198290299184;4638.304254361873;4682.812687492462;4764.809407623726;4807.230843065093;4770.379850619397;4800.543948324904;4804.25534042224;4811.78346974387;4812.037592481448;3641.380965235863;3724.0689827543115;3735.9252814943547;3740.8129593520757;3767.849286028583;3341.74936879735;3399.3201359728155;3411.181316484026;3415.7608967372544;3435.038189306998;4581.541845815392;4584.4498660160325;4595.195840727859;4605.516420775837;4607.562281583244;4750.881227969328;4929.433115191727;4944.703317800943;4949.802007919643;4964.15609346412;4459.620932220732;4507.076049409863;4509.684322097487;4548.909021819545;4586.954130458719;4251.256030194703;4306.504751953503;4320.913581728348;4358.956410435855;4360.978195109004;4689.718616882861;4867.0995865764235;4946.159152944008;4948.703077815343;4978.975105124451;4756.8097276108565;4934.087193869145;4939.382577177853;4941.33292005589;4974.925376119289;4971.37857767779;5006.674566153189;5009.273655319886;5011.699298042129;5069.5944324454695;4746.501617330131;4865.6107511398295;4928.67963582366;4929.9014019720125;4959.256111583291;4681.321208424827;4700.623950084054;4837.443693975097;4844.563989240844;4870.805167793249;4784.7607619619575;4816.494268101939;4871.147549178809;4890.266460031024;4898.167311556973;4479.216137176047;4775.95224047769;4842.903141937071;4859.927101093415;4867.050925069719;4542.909141817079;4666.160091183619;4684.1334353144775;4687.1328804171335;4697.13103075932;4790.473047964651;4813.78337974799;4844.878878028077;4859.2954021667365;4870.756462176806;4518.390017347748;4684.250519916797;4722.787474563722;4763.4522029967;4793.952060479351 15:01:00 INFO - 2015-12-03 15:01:00,898 DEBUG : BROWSER_OUTPUT: |1;ext.html;468.4753076554259;476.98640389173005;479.0658216477868;480.2124515794096;507.25940127413975;26878.19365419038;27546;32559.1860203495;32955.340893182125;33154.33691326178;35330.64669353305;35403.29193416137;35526.8223658882;35613.46579801305;35627.10932226696;7085.787426377217;7711.961440192791;7899.091604465502;7899.881501777478;7906.604669766518;7233.348998590126;9176.220021298164;9425.387349822275;9456.527173641325;9488.762780930463;9215.262778977665;9372.531373431335;9372.531373431335;9441.716748497556;9464.290178236626;7361.889571656429;7547.28300811422;9176.632934682604;9276.304277179239;9417.105374989365;9008.459492430475;9227.53862306882;9267.351285410025;9319.487428191447;9354.812903741888;32770.344593108006;33194.50208246854;33446.83276583626;33601.83199084013;33690.1577460563;2510.3222130024974;2514.421683012917;2590.235880415282;2865.6704478984975;2876.3528206153655;22471.438214044618;23093;23353.416164595852;23915.04339826422;24079.759202407928;1900.2114122639089;1922.9903850480657;1959.8922059286733;1971.0834461975107;2006.3178519303508;244569;245784.99999999822;247419;251426;251970;46348.536514635096;47497;49483.25775113376;49970.50029499731;53767.19349209765;49884.50115498871;50304.74847625739;50553;50777;51374.22938655923;14114.435422582981;14399.352029158714;14428.927855360656;14435.206063666388;14567.92716036413;10924.508397122148;10943.398113103696;11021.559137634405;11078.778424431466;11148.219624626197;15896.364145434285;16009.439669611507;16178.59553511148;16256.593585160466;16340.67318653644;6718.160229971254;6903.344182302673;6973.302669732986;6983.196932352845;7019.333163349474;778.1906816910463;792.4413288631501;838.149278482341;883.0948278014957;937.4515908193647;21721.782782172293;22106.33680989573;22262.219022478163;22323.776762232494;22366.217182398537;874.8862647855738;936.1761649748178;950.6387572722322;1031.9380837149795;1079.5951518180682;9051.909480905239;10315.27793054479;11781.587644432404;11825.52697892092;11861.229020113666;288303;290861;291396;291494;294774;38829.41755873664;39898.40152397716;45104.3234351485;45384;45400.77299613481;1168.1122347016328;1188.506769690586;1199.5022065842752;1211.9091068169923;1216.2033867816594;22933.65599516042;23106.422339440975;23890.88054559716;24252.393690157885;24276.51446971086;36900.26199476049;37498.25003499969;37918;42594.14811703811;43118;188136;188480;189737;192221;192401;26120.216393508224;26135.73864261409;27035.459290814466;27056.917723291634;27059.323516912234;33733.3253334927;33991;34580.82709586436;34650.13374665654;35104.648953510135;27786.16641500758;28528.42943141084;28648;28688.28279292951;28691.426171476036;29103.85448072746;29271.70728292775;29372.55941160927;29544.113676589735;29594.96417625373;30056.549151763178;30184.24539386445;30305.69694303117;30384.5442318361;30397.848010759804;24896.751032489443;25480.362990925376;25714.742852571235;26081.217563473125;26385.472290554466;18948.336808211647;19686.60626787485;19882.60234795267;20095.296664616668;20991 15:01:00 INFO - 2015-12-03 15:01:00,899 DEBUG : BROWSER_OUTPUT: |2;jquery.html;295.51978035692;300.16703647378523;304.45806464493205;306.4193353594939;311.4052160373686;12697.365131743421;13074.542391016317;14490.637734056641;14802.111873287611;14860.777088343684;13186.604401867959;14725.410983560645;15692.84307156931;16285.267162977694;16290.674186516262;4472.239719247736;4552.203364411214;4567.92653726374;4604.7927843247135;4648.070385922829;3486.0936156599214;3553.5380400547892;3559.305935342596;4609.7234165949985;4678.789454474557;4847.466778654345;5013.398392192942;5024.497550244964;5032.119379108642;5048;4892.461829198785;4929.2359684248995;4988.925166122511;5032.043911656773;5047.596192304625;4371.803268852909;4413.227685155085;4419;4431.645468362523;4433.091216300683;18802.717959230486;19035.524111897175;19058.047097645063;19170.424887253404;19271.325503607306;1665.5419759566096;1712.049812354143;1718.9742153867703;1753.2986805277862;1985.662437385648;11504.942475287653;11718.296902185895;11804.232724872942;11838.230515016583;12219.633410997685;1425.7077299153752;1447.5295528953027;1458.585172382787;1476.3725416697969;1514.7803568482618;50990.49009509895;52777.73611131958;53080.20379694346;53096.469035309536;53158.20262696063;8085.757427277191;8234.711785087493;8774.692885749097;8782.560871956377;8869.512176830207;10788.40663763485;10804.729881752863;10814.675559733221;10817.513211905483;10891.128709703205;6898.068760717239;6910.827229319308;6932.306769323128;6934.7226110955;6945.548539344926;6883.8967415488805;6932.480063995221;6956.234814170437;6986.825329366807;7057.647117644097;5097.8725531862;5102.132637451642;5156.7421628919155;5194.558462530727;5212.348456442945;1369.3153423288356;1444.7688369860982;1492.7984722062383;1501.196859680066;1507.8718308943644;781.8319061401712;838.7944953486435;849.613425891218;856.3320609924269;879.8724184993268;9514.714558563253;9535.570899309549;9597.28020398459;14317.6420589484;15475.922620386826;367.9576848662438;369.3444136657401;389.2312682452191;393.50614978202174;408.4016915219218;4924.384451943507;5379.569634429236;5397.3523177218985;5514.172874068921;5521.171824226398;507172;528788;529284;555608;561305;61239.38760612337;61371.69314153401;61926;62132.68933655303;62674.37325626777;438.6337408264071;442.3364952571079;443.52542779225917;445.4142802215077;452.88451444881343;8756.168164024408;9020.729378118667;9081.45511269326;9320.72037838866;9396.530173491436;28686.713132869238;28908.277293067;29255.561166582094;29395.11814645564;29658;40851.591484084776;41014.79492602518;41169.794151029055;41385.79307103445;41579.584204157574;5508.228847961369;11710.88289117132;12056;12058.216215945935;12209.145359824726;15082.54752357431;15666.37334506607;16262.837371626605;16303.59241018984;16566.17169141514;9814.75463113428;12701.4284357206;13058.281794501014;13087.541936032194;13164.407601657756;7308.659183114802;7583.203763604963;7715.768526944201;12328.691782705504;12411.813822792485;8388.496690198608;8460.788480288042;8500.74497765068;8517.95741021291;8572.35707321941;12303;13111.40998655082;13277.867221327662;13690.45238190501;13914.791278130633;13260.204387736767;13500.729985400041;13648.727025459237;13779.724405512034;14115.01194916346 15:01:00 INFO - 2015-12-03 15:01:00,903 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1132.6941725734048;1451.3831621560835;1503.353557970073;1514.666773309872;1555.774412710157;5901.055831067025;6148.631082135075;6225.533085018619;6363.300036995926;6407.070974708665;6412.615243085418;6518.543701940866;6524.249711283204;6542.084108224841;6643.534952553323;1879.2670858365282;1908.5419499320133;1914.5692219250695;1917.0798016951871;1926.7206255093004;1909.2744756992324;1912.9808701912941;1938.8836669799857;1944.572194117292;1949.6393167264102;1898.1837809741805;1926.4509614759797;1935.912883920227;1943.4072607854598;1944.1931598386652;1825.8904465732032;1886.518937670892;1889.3576184097474;1897.8197071278344;1902.9333973310936;1836.6785812482763;1881.9247230110916;1888.8488920886296;1889.962200755991;1928.884266943974;5885.8822823543715;6403.263624683174;6416.165898433221;6422.871542569169;6465.3857883501;3726.496922915399;3786.3752480840626;3895.162540053902;4045.3325201341745;4052.9797351013353;2427.2718184544565;2521.747825217482;2546.6689330387117;2547.1339744486777;2569.2677586887835;727.5089314712601;741.6291854072964;755.5267228903659;762.306301265851;766.7048186448202;8439;8536.402451828375;8574.785630359229;8594.226519613265;8663.74008779744;3595.1371670799344;3624.9637503624626;3689.2990331836863;3719.702423806089;3723.255348930225;7549.886751698729;7605.353544948742;7647.961760191163;7712.691492340244;7725.343345815556;4013.538443079025;4083.0813067059676;4088.8160032798596;4112.383142528644;4145.046639272984;3716.8699095532065;3720.720945929066;3744.868929587506;3753.9061523462133;3760.022394177479;2992.9102126936227;3015.562743402238;3058.3271680230314;3075;3101.286704058079;953.2278854128178;969.7866469376726;971.0726256425097;972.0959507657946;994.8955359687128;852.8550146475114;893.5755516129786;897.1028971028971;902.0483390023458;984.3306551544875;6077.4834139098675;6166.753329866845;6179.721912513947;6199.969000154971;6238.1266622672865;957.3872721458272;994.8358520844124;996.7906739584623;1015.4516561056946;1018.9796204075877;4579.74811385377;4839.443464001614;4873.488283730228;4885.5847252983185;4911.705297682151;7082.29177082298;7392.1499027611435;7500.662470188855;7615.2865605239485;7635.31282184595;7447.739329123455;7478.439117066133;7500.962495187489;7502.887456688154;7510.248975102555;5954.136650185699;5973.910391344133;6044.153818465418;6100.48145907594;6158.907616385758;6169.475594574512;6186.1339412483185;6189.81430557084;6209.254889413119;6253.062040693932;6778.389944904785;6850.520463567702;6926.238113807376;6955.791326260221;6986.231514533296;6929.653517324215;7066.04608377883;7134.2152363238965;7150.5352152109945;7164.820879478055;5835.978703726916;5874.823755287348;5877.265341832271;5898.4101589840675;5905.911411328748;6167.907481387872;6203.069539569101;6260.123582698517;6265.028920517327;6266.310705822447;5768.913466298093;5788;5887.326185124176;5901.734421951109;5911.615744976562;5538.556915446674;5707.315122185364;5749.913751293818;5763.991301522301;5891.970540147272;5829.3296270927685;5880.794172203952;5898.203742494708;5917.260342457193;5923.822285331447;5259.815906443409;5332.22682710997;5407.486288802715;5408.702521361363;5434.64674796137;5353.384360798403;5374.543163831118;5486.286782718221;5493.560515158698;5506.201600767786 15:01:00 INFO - 2015-12-03 15:01:00,903 DEBUG : BROWSER_OUTPUT: |4;prototype.html;265.9946801063979;272.4632474026168;276.09441033410417;281.53125046797084;287.2588721099563;5151.995360904625;5172.586193104552;5193.844184674461;5230.21546767985;5236.73816309184;5023.422306434761;5026.9497305026935;5092.974535127329;5121.590272778178;5166.638335316529;3946.289667859784;3960.623740744632;3974.7615143091507;3976.542697589771;3982.8406863725418;3843.4811300474357;3883.864064757734;3913.6869050476034;3941.60583941605;3985.083430810915;3870.651641352292;3878.8448462061483;3939.862104826317;3942.349512330462;3984.0836607580272;3909.4135879618;3917.3928041153667;3922.8234729437245;3938.0154961259686;3963.0686788604653;3402.5066365376883;3417.4361230396953;3429.6741809528053;3456.5679290088738;3469.826508674556;4776.11641846256;4909.509049095098;4932.112219800434;4976.552110310089;4997.575206107485;4368.148211098837;4497.572730590588;4501.977490112561;4543.0459603483305;4543.931841022388;5333.35999680037;5355.518003379714;5434.728263586844;5440.183972404171;5446.074167391553;3572.1248294168095;3654.488371627948;3718.200586873808;3764.9058773530605;3828.712846536521;5438.510534051915;5493.450654934514;5532.28080349552;5558.221848941152;5577.776888924438;3786.5077539919635;3791.184895247535;3804.885853424402;3804.961950380516;3816;3835.6356146166067;3855.5373355197557;3864.091938394475;3891.455196272524;3912;4350;4423.845165419195;4431.423914891044;4432.667549933768;4488.842890498817;5366.490183432567;5392.595555333287;5429.131338985743;5455.699936503531;5458.935507576064;1392.9930350348184;1402.4179965314484;1407.9577612671637;1416.95040673578;1430.106183635228;905.542700936023;905.5970093308546;910.3672947301694;941.204682043672;941.5151197133482;4971.950280497221;5029.1953287473825;5120.8719782005;5126.051680439131;5143.614228932845;5506.1190209566275;5586.078297081018;5595.8601034973635;5611.2144299798065;5616.466435688603;5034.924476132861;5099.082165210298;5099.949000509948;5126.769295381717;5129.461406552333;3028.3337665713507;3079.5072788353755;3100.5969224001187;3106.673799251046;3109.673484284163;5689.459501347448;5689.6586204827845;5703.17303990919;5726.627769194989;5736.053551164095;5747.425257474303;5778.3354914184565;5782.306123265235;5810.157527158538;5853.970730146407;5683.687397193194;5687.829365118971;5711.7144142792695;5736.6558006519745;5808.041673123887;5498.202760599771;5607.859803504945;5624.943750562442;5689.374168841341;5721.914171287351;5473.2063850742215;5503.834884953458;5542.9168562472405;5557.305336832896;5623.943760562342;5520.696361700145;5556.083246264483;5559.52744016747;5641.661500309994;5719.799807006735;3681.8527258910417;3699.6300369962787;3718.8140592969703;3746.9063273418383;3758.2671379080816;5539.975104605661;5570.721463926869;5574.498295153456;5575.693336866511;5613.410591887956;5255.185446255837;5426.70153141581;5448.291722076105;5494.36814766291;5494.752736126964;5546.4453554644215;5560.2493663356545;5580.972095139498;5583.748731307182;5603.495685388335;5369.97315013438;5376.435474275145;5391.595630327663;5407.107827208624;5475.945240547543;5498.285222920995;5502.889942201214;5514.834554963358;5564.360098588714;5581.330240371181;5236.659617124875;5387.838364849061;5390.892182156414;5401.945980540144;5450.91823622638 15:01:00 INFO - 2015-12-03 15:01:00,907 DEBUG : BROWSER_OUTPUT: |5;yui.html;548.5803360429272;559.6586082489681;576.6511260687284;616.1374076293192;645.6448953075809;11350.886491135087;11963.521459141624;11965.940170299158;11974.580889668863;12008.339541325224;11828.940855295734;12075.765983293097;12091.697707557294;12099.032077433807;12222.572209972654;598.7096258314714;601.4917394801386;711.6655172069133;733.9596322202277;741.2069086077898;758.5827794712914;770.8072981754561;780.6174974262627;781.4061313401827;782.3428320211021;776.1307335783902;782.2607635784186;785.0775338976708;790.9841803163933;797.7487091566167;629.7701339011273;649.7011374767612;762.7330434347989;779.5712358203023;813.9633716482742;584.2784161560469;587.1632923084587;592.8606777407306;594.5035895027657;597.4145337569163;11862.466189021514;11905.940470297679;11915.523379064827;12042.69893252667;12095.21381110225;9877.209823214125;9901;10099.495025248782;10394.688159355232;10803.945980270128;7721.691132354699;7774;7793.454458187873;8011.399145064085;8253.95873020637;2820.9435811283865;2860.0561814601133;2866.5270230411957;2913.2716820794803;2956.793024488287;39960.20079598392;40550.79724601358;40988.79505602483;41221.79389103036;41452.37821432681;7838.752508261021;7897.24976127267;8013.198680132056;8106.837863242702;8173.060098088796;16937.745933811002;16947.915260423866;17044.744328835077;17058.402955896483;17171.484855454357;5658.377578466366;5823.505002074871;5919.408059194132;5976.133460648181;6118.265808103056;3167.2715275486767;3236.093893709765;3337.249118948217;3343.1809206744015;3418.247985443248;2751.9036833710725;2775.9444811103663;2778.263760103574;2780.708025657317;2790.6651201855907;375.28133624109523;394.54627178744676;396.1206122408249;397.52892822006015;484.1478996965366;455.703792534855;486.95373939475695;487.6903166489234;497.19702680171264;515.1757188498448;6188.907166392508;6246;6414.262359828586;6496.155499784998;6573.375529324802;509.4574278393499;513.117438006628;513.1968469345537;524.9947500524946;536.8792021795143;2886.985565072161;3219.8390080495883;3274.5251938468787;3291.4240007998983;3362.2434952136064;53884.46115538873;53900;54656.72671636617;54844.33823125079;54849.725751370985;45743.54256457393;46847.76576117097;46873.76563117231;46885.76557117193;46944.295835562494;41731.791341042495;42085.1582968345;42766.78616606959;43056.3541546877;43572.346414803804;6624.171978502687;6665.866682666223;6735.595864248161;6781.898271525833;7075.752348667772;29937;29949.251268718457;31349.529757053206;32120.839395802872;32128.839355803073;38059;38077.238455231294;38143.42784858174;39930.20139597134;41410.79294603508;6183.783567575293;6200.503959683305;6379.649119298483;6795.762148324785;6893.620850853251;9307.395019323721;9501.904980950101;9671;9754.707358779247;9953.950230248802;8631;8804.163604457566;8843;8843.646254150019;9121.543922803967;8729.869051964099;8821.117888211384;9194.448333100036;9320.906790932275;9510.38182518134;8597.226249637562;8620.741377758677;8710.69512567057;8871.112888711335;9306.488143152192;7368.815779605553;7418.851622967402;7591.4685971983645;7615.847683046419;7888.802779930547;7118.786436406916;7521.623918803928;7544.811379715551;7616.428767842544;7670.846583068196 15:01:00 INFO - 2015-12-03 15:01:00,907 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:01:00 INFO - 2015-12-03 15:01:00,908 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:01:00 INFO - 2015-12-03 15:01:00,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 15:01:00 INFO - 2015-12-03 15:01:00,908 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:01:00 INFO - 2015-12-03 15:01:00,908 DEBUG : BROWSER_OUTPUT: __startTimestamp1449183660890__endTimestamp 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4527.11 Median:4681.32 stddev:504.04 (10.8%) stddev-sans-first:482.44 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: Values: 2602.3 2664.8 2667.2 2672.0 2700.2 4561.7 4564.3 4577.0 4592.7 4662.2 4584.4 4589.3 4596.1 4623.4 4653.2 4179.1 4214.5 4233.2 4271.3 4317.4 4058.6 4066.3 4086.3 4104.2 4105.0 3807.8 4045.9 4058.4 4097.9 4113.3 4097.3 4134.4 4210.0 4241.4 4254.3 4163.8 4202.4 4211.7 4241.2 4259.1 4301.7 4514.4 4536.3 4585.9 4589.3 4684.4 4782.5 4792.8 4822.1 4838.7 4838.7 4863.7 4879.6 4881.0 4920.5 4406.6 4548.0 4560.1 4566.6 4577.6 4947.4 4956.2 4992.6 5087.7 5090.7 4811.4 4855.7 4869.2 4879.0 4912.0 4648.8 5013.8 5027.9 5029.2 5030.2 4581.2 4638.3 4682.8 4764.8 4807.2 4770.4 4800.5 4804.3 4811.8 4812.0 3641.4 3724.1 3735.9 3740.8 3767.8 3341.7 3399.3 3411.2 3415.8 3435.0 4581.5 4584.4 4595.2 4605.5 4607.6 4750.9 4929.4 4944.7 4949.8 4964.2 4459.6 4507.1 4509.7 4548.9 4587.0 4251.3 4306.5 4320.9 4359.0 4361.0 4689.7 4867.1 4946.2 4948.7 4979.0 4756.8 4934.1 4939.4 4941.3 4974.9 4971.4 5006.7 5009.3 5011.7 5069.6 4746.5 4865.6 4928.7 4929.9 4959.3 4681.3 4700.6 4837.4 4844.6 4870.8 4784.8 4816.5 4871.1 4890.3 4898.2 4479.2 4776.0 4842.9 4859.9 4867.1 4542.9 4666.2 4684.1 4687.1 4697.1 4790.5 4813.8 4844.9 4859.3 4870.8 4518.4 4684.3 4722.8 4763.5 4794.0 15:01:00 INFO - 2015-12-03 15:01:00,909 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,910 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38533.98 Median:162159.06 stddev:64579.58 (39.8%) stddev-sans-first:64697.50 15:01:00 INFO - 2015-12-03 15:01:00,910 DEBUG : BROWSER_OUTPUT: Values: 468.5 477.0 479.1 480.2 507.3 26878.2 27546.0 32559.2 32955.3 33154.3 35330.6 35403.3 35526.8 35613.5 35627.1 7085.8 7712.0 7899.1 7899.9 7906.6 7233.3 9176.2 9425.4 9456.5 9488.8 9215.3 9372.5 9372.5 9441.7 9464.3 7361.9 7547.3 9176.6 9276.3 9417.1 9008.5 9227.5 9267.4 9319.5 9354.8 32770.3 33194.5 33446.8 33601.8 33690.2 2510.3 2514.4 2590.2 2865.7 2876.4 22471.4 23093.0 23353.4 23915.0 24079.8 1900.2 1923.0 1959.9 1971.1 2006.3 244569.0 245785.0 247419.0 251426.0 251970.0 46348.5 47497.0 49483.3 49970.5 53767.2 49884.5 50304.7 50553.0 50777.0 51374.2 14114.4 14399.4 14428.9 14435.2 14567.9 10924.5 10943.4 11021.6 11078.8 11148.2 15896.4 16009.4 16178.6 16256.6 16340.7 6718.2 6903.3 6973.3 6983.2 7019.3 778.2 792.4 838.1 883.1 937.5 21721.8 22106.3 22262.2 22323.8 22366.2 874.9 936.2 950.6 1031.9 1079.6 9051.9 10315.3 11781.6 11825.5 11861.2 288303.0 290861.0 291396.0 291494.0 294774.0 38829.4 39898.4 45104.3 45384.0 45400.8 1168.1 1188.5 1199.5 1211.9 1216.2 22933.7 23106.4 23890.9 24252.4 24276.5 36900.3 37498.3 37918.0 42594.1 43118.0 188136.0 188480.0 189737.0 192221.0 192401.0 26120.2 26135.7 27035.5 27056.9 27059.3 33733.3 33991.0 34580.8 34650.1 35104.6 27786.2 28528.4 28648.0 28688.3 28691.4 29103.9 29271.7 29372.6 29544.1 29595.0 30056.5 30184.2 30305.7 30384.5 30397.8 24896.8 25480.4 25714.7 26081.2 26385.5 18948.3 19686.6 19882.6 20095.3 20991.0 15:01:00 INFO - 2015-12-03 15:01:00,910 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,910 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26652.81 Median:2405.22 stddev:87549.01 (3640.0%) stddev-sans-first:87772.24 15:01:00 INFO - 2015-12-03 15:01:00,912 DEBUG : BROWSER_OUTPUT: Values: 295.5 300.2 304.5 306.4 311.4 12697.4 13074.5 14490.6 14802.1 14860.8 13186.6 14725.4 15692.8 16285.3 16290.7 4472.2 4552.2 4567.9 4604.8 4648.1 3486.1 3553.5 3559.3 4609.7 4678.8 4847.5 5013.4 5024.5 5032.1 5048.0 4892.5 4929.2 4988.9 5032.0 5047.6 4371.8 4413.2 4419.0 4431.6 4433.1 18802.7 19035.5 19058.0 19170.4 19271.3 1665.5 1712.0 1719.0 1753.3 1985.7 11504.9 11718.3 11804.2 11838.2 12219.6 1425.7 1447.5 1458.6 1476.4 1514.8 50990.5 52777.7 53080.2 53096.5 53158.2 8085.8 8234.7 8774.7 8782.6 8869.5 10788.4 10804.7 10814.7 10817.5 10891.1 6898.1 6910.8 6932.3 6934.7 6945.5 6883.9 6932.5 6956.2 6986.8 7057.6 5097.9 5102.1 5156.7 5194.6 5212.3 1369.3 1444.8 1492.8 1501.2 1507.9 781.8 838.8 849.6 856.3 879.9 9514.7 9535.6 9597.3 14317.6 15475.9 368.0 369.3 389.2 393.5 408.4 4924.4 5379.6 5397.4 5514.2 5521.2 507172.0 528788.0 529284.0 555608.0 561305.0 61239.4 61371.7 61926.0 62132.7 62674.4 438.6 442.3 443.5 445.4 452.9 8756.2 9020.7 9081.5 9320.7 9396.5 28686.7 28908.3 29255.6 29395.1 29658.0 40851.6 41014.8 41169.8 41385.8 41579.6 5508.2 11710.9 12056.0 12058.2 12209.1 15082.5 15666.4 16262.8 16303.6 16566.2 9814.8 12701.4 13058.3 13087.5 13164.4 7308.7 7583.2 7715.8 12328.7 12411.8 8388.5 8460.8 8500.7 8518.0 8572.4 12303.0 13111.4 13277.9 13690.5 13914.8 13260.2 13500.7 13648.7 13779.7 14115.0 15:01:00 INFO - 2015-12-03 15:01:00,912 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,912 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4538.43 Median:5895.09 stddev:2301.05 (39.0%) stddev-sans-first:2293.26 15:01:00 INFO - 2015-12-03 15:01:00,913 DEBUG : BROWSER_OUTPUT: Values: 1132.7 1451.4 1503.4 1514.7 1555.8 5901.1 6148.6 6225.5 6363.3 6407.1 6412.6 6518.5 6524.2 6542.1 6643.5 1879.3 1908.5 1914.6 1917.1 1926.7 1909.3 1913.0 1938.9 1944.6 1949.6 1898.2 1926.5 1935.9 1943.4 1944.2 1825.9 1886.5 1889.4 1897.8 1902.9 1836.7 1881.9 1888.8 1890.0 1928.9 5885.9 6403.3 6416.2 6422.9 6465.4 3726.5 3786.4 3895.2 4045.3 4053.0 2427.3 2521.7 2546.7 2547.1 2569.3 727.5 741.6 755.5 762.3 766.7 8439.0 8536.4 8574.8 8594.2 8663.7 3595.1 3625.0 3689.3 3719.7 3723.3 7549.9 7605.4 7648.0 7712.7 7725.3 4013.5 4083.1 4088.8 4112.4 4145.0 3716.9 3720.7 3744.9 3753.9 3760.0 2992.9 3015.6 3058.3 3075.0 3101.3 953.2 969.8 971.1 972.1 994.9 852.9 893.6 897.1 902.0 984.3 6077.5 6166.8 6179.7 6200.0 6238.1 957.4 994.8 996.8 1015.5 1019.0 4579.7 4839.4 4873.5 4885.6 4911.7 7082.3 7392.1 7500.7 7615.3 7635.3 7447.7 7478.4 7501.0 7502.9 7510.2 5954.1 5973.9 6044.2 6100.5 6158.9 6169.5 6186.1 6189.8 6209.3 6253.1 6778.4 6850.5 6926.2 6955.8 6986.2 6929.7 7066.0 7134.2 7150.5 7164.8 5836.0 5874.8 5877.3 5898.4 5905.9 6167.9 6203.1 6260.1 6265.0 6266.3 5768.9 5788.0 5887.3 5901.7 5911.6 5538.6 5707.3 5749.9 5764.0 5892.0 5829.3 5880.8 5898.2 5917.3 5923.8 5259.8 5332.2 5407.5 5408.7 5434.6 5353.4 5374.5 5486.3 5493.6 5506.2 15:01:00 INFO - 2015-12-03 15:01:00,913 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,914 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4529.59 Median:5169.61 stddev:1361.62 (26.3%) stddev-sans-first:1327.30 15:01:00 INFO - 2015-12-03 15:01:00,915 DEBUG : BROWSER_OUTPUT: Values: 266.0 272.5 276.1 281.5 287.3 5152.0 5172.6 5193.8 5230.2 5236.7 5023.4 5026.9 5093.0 5121.6 5166.6 3946.3 3960.6 3974.8 3976.5 3982.8 3843.5 3883.9 3913.7 3941.6 3985.1 3870.7 3878.8 3939.9 3942.3 3984.1 3909.4 3917.4 3922.8 3938.0 3963.1 3402.5 3417.4 3429.7 3456.6 3469.8 4776.1 4909.5 4932.1 4976.6 4997.6 4368.1 4497.6 4502.0 4543.0 4543.9 5333.4 5355.5 5434.7 5440.2 5446.1 3572.1 3654.5 3718.2 3764.9 3828.7 5438.5 5493.5 5532.3 5558.2 5577.8 3786.5 3791.2 3804.9 3805.0 3816.0 3835.6 3855.5 3864.1 3891.5 3912.0 4350.0 4423.8 4431.4 4432.7 4488.8 5366.5 5392.6 5429.1 5455.7 5458.9 1393.0 1402.4 1408.0 1417.0 1430.1 905.5 905.6 910.4 941.2 941.5 4972.0 5029.2 5120.9 5126.1 5143.6 5506.1 5586.1 5595.9 5611.2 5616.5 5034.9 5099.1 5099.9 5126.8 5129.5 3028.3 3079.5 3100.6 3106.7 3109.7 5689.5 5689.7 5703.2 5726.6 5736.1 5747.4 5778.3 5782.3 5810.2 5854.0 5683.7 5687.8 5711.7 5736.7 5808.0 5498.2 5607.9 5624.9 5689.4 5721.9 5473.2 5503.8 5542.9 5557.3 5623.9 5520.7 5556.1 5559.5 5641.7 5719.8 3681.9 3699.6 3718.8 3746.9 3758.3 5540.0 5570.7 5574.5 5575.7 5613.4 5255.2 5426.7 5448.3 5494.4 5494.8 5546.4 5560.2 5581.0 5583.7 5603.5 5370.0 5376.4 5391.6 5407.1 5475.9 5498.3 5502.9 5514.8 5564.4 5581.3 5236.7 5387.8 5390.9 5401.9 5450.9 15:01:00 INFO - 2015-12-03 15:01:00,915 DEBUG : BROWSER_OUTPUT: 15:01:00 INFO - 2015-12-03 15:01:00,915 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11905.67 Median:3117.51 stddev:14594.28 (468.1%) stddev-sans-first:14610.30 15:01:00 INFO - 2015-12-03 15:01:00,916 DEBUG : BROWSER_OUTPUT: Values: 548.6 559.7 576.7 616.1 645.6 11350.9 11963.5 11965.9 11974.6 12008.3 11828.9 12075.8 12091.7 12099.0 12222.6 598.7 601.5 711.7 734.0 741.2 758.6 770.8 780.6 781.4 782.3 776.1 782.3 785.1 791.0 797.7 629.8 649.7 762.7 779.6 814.0 584.3 587.2 592.9 594.5 597.4 11862.5 11905.9 11915.5 12042.7 12095.2 9877.2 9901.0 10099.5 10394.7 10803.9 7721.7 7774.0 7793.5 8011.4 8254.0 2820.9 2860.1 2866.5 2913.3 2956.8 39960.2 40550.8 40988.8 41221.8 41452.4 7838.8 7897.2 8013.2 8106.8 8173.1 16937.7 16947.9 17044.7 17058.4 17171.5 5658.4 5823.5 5919.4 5976.1 6118.3 3167.3 3236.1 3337.2 3343.2 3418.2 2751.9 2775.9 2778.3 2780.7 2790.7 375.3 394.5 396.1 397.5 484.1 455.7 487.0 487.7 497.2 515.2 6188.9 6246.0 6414.3 6496.2 6573.4 509.5 513.1 513.2 525.0 536.9 2887.0 3219.8 3274.5 3291.4 3362.2 53884.5 53900.0 54656.7 54844.3 54849.7 45743.5 46847.8 46873.8 46885.8 46944.3 41731.8 42085.2 42766.8 43056.4 43572.3 6624.2 6665.9 6735.6 6781.9 7075.8 29937.0 29949.3 31349.5 32120.8 32128.8 38059.0 38077.2 38143.4 39930.2 41410.8 6183.8 6200.5 6379.6 6795.8 6893.6 9307.4 9501.9 9671.0 9754.7 9954.0 8631.0 8804.2 8843.0 8843.6 9121.5 8729.9 8821.1 9194.4 9320.9 9510.4 8597.2 8620.7 8710.7 8871.1 9306.5 7368.8 7418.9 7591.5 7615.8 7888.8 7118.8 7521.6 7544.8 7616.4 7670.8 15:01:00 INFO - 2015-12-03 15:01:00,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:01:00 INFO - 2015-12-03 15:01:00,917 DEBUG : BROWSER_OUTPUT: 15:01:01 INFO - 2015-12-03 15:01:01,602 INFO : Browser exited with error code: 0 15:01:01 INFO - 2015-12-03 15:01:01,635 INFO : Completed test dromaeo_css (00:18:35) 15:01:01 INFO - 2015-12-03 15:01:01,635 INFO : Starting test kraken 15:01:01 INFO - 2015-12-03 15:01:01,635 DEBUG : operating with platform_type : mac_ 15:01:01 INFO - 2015-12-03 15:01:01,635 INFO : Initialising browser for kraken test... 15:01:01 INFO - 2015-12-03 15:01:01,652 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpoyq86M/profile http://localhost:49271/getInfo.html 15:01:04 INFO - 2015-12-03 15:01:04,169 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:01:04 INFO - 2015-12-03 15:01:04,169 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:01:04 INFO - 2015-12-03 15:01:04,169 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:01:04 INFO - 2015-12-03 15:01:04,169 DEBUG : BROWSER_OUTPUT: __metrics 15:01:04 INFO - 2015-12-03 15:01:04,187 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:01:04 INFO - 2015-12-03 15:01:04,896 INFO : Browser initialized. 15:01:04 INFO - 2015-12-03 15:01:04,896 INFO : Running cycle 1/1 for kraken test... 15:01:04 INFO - 2015-12-03 15:01:04,896 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpoyq86M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:01:16 INFO - 2015-12-03 15:01:16,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 198008832 15:01:16 INFO - 2015-12-03 15:01:16,915 DEBUG : BROWSER_OUTPUT: 15:01:19 INFO - 2015-12-03 15:01:19,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 15:01:20 INFO - 2015-12-03 15:01:20,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 264945664 15:01:20 INFO - 2015-12-03 15:01:20,467 DEBUG : BROWSER_OUTPUT: 15:01:23 INFO - 2015-12-03 15:01:23,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 15:01:24 INFO - 2015-12-03 15:01:24,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 279306240 15:01:24 INFO - 2015-12-03 15:01:24,097 DEBUG : BROWSER_OUTPUT: 15:01:27 INFO - 2015-12-03 15:01:27,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 15:01:27 INFO - 2015-12-03 15:01:27,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 268304384 15:01:27 INFO - 2015-12-03 15:01:27,988 DEBUG : BROWSER_OUTPUT: 15:01:30 INFO - 2015-12-03 15:01:30,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 15:01:30 INFO - 2015-12-03 15:01:30,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 268640256 15:01:30 INFO - 2015-12-03 15:01:30,972 DEBUG : BROWSER_OUTPUT: 15:01:33 INFO - 2015-12-03 15:01:33,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:01:34 INFO - 2015-12-03 15:01:34,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 269332480 15:01:34 INFO - 2015-12-03 15:01:34,053 DEBUG : BROWSER_OUTPUT: 15:01:37 INFO - 2015-12-03 15:01:37,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 15:01:38 INFO - 2015-12-03 15:01:38,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 264634368 15:01:38 INFO - 2015-12-03 15:01:38,201 DEBUG : BROWSER_OUTPUT: 15:01:41 INFO - 2015-12-03 15:01:41,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 15:01:42 INFO - 2015-12-03 15:01:42,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 262934528 15:01:42 INFO - 2015-12-03 15:01:42,437 DEBUG : BROWSER_OUTPUT: 15:01:45 INFO - 2015-12-03 15:01:45,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 15:01:46 INFO - 2015-12-03 15:01:46,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 265105408 15:01:46 INFO - 2015-12-03 15:01:46,391 DEBUG : BROWSER_OUTPUT: 15:01:48 INFO - 2015-12-03 15:01:48,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:01:48 INFO - 2015-12-03 15:01:48,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 298401792 15:01:48 INFO - 2015-12-03 15:01:48,738 DEBUG : BROWSER_OUTPUT: 15:01:50 INFO - 2015-12-03 15:01:50,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:01:51 INFO - 2015-12-03 15:01:51,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 301887488 15:01:51 INFO - 2015-12-03 15:01:51,426 DEBUG : BROWSER_OUTPUT: 15:01:53 INFO - 2015-12-03 15:01:53,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:01:54 INFO - 2015-12-03 15:01:54,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 306647040 15:01:54 INFO - 2015-12-03 15:01:54,347 DEBUG : BROWSER_OUTPUT: 15:01:57 INFO - 2015-12-03 15:01:57,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:01:57 INFO - 2015-12-03 15:01:57,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 310284288 15:01:57 INFO - 2015-12-03 15:01:57,895 DEBUG : BROWSER_OUTPUT: 15:02:00 INFO - 2015-12-03 15:02:00,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:02:01 INFO - 2015-12-03 15:02:01,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 308957184 15:02:01 INFO - 2015-12-03 15:02:01,387 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 15:02:03 INFO - 2015-12-03 15:02:03,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 368164864 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:02:03 INFO - 2015-12-03 15:02:03,574 DEBUG : BROWSER_OUTPUT: |0;ai-astar;129;130;135;131;134;136;137;134;135;135 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;182;156;193;190;160;186;153;188;181;155 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;196;195;195;197;197;199;205;203;196 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |3;audio-fft;93;92;93;193;81;82;84;86;150;84 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;115;120;164;112;114;112;150;106;105;154 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;147;142;143;141;149;149;148;141;141;142 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;153;153;154;153;153;153;153;153;153;154 15:02:03 INFO - 2015-12-03 15:02:03,575 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;125;123;129;130;129;124;124;124;128;131 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;72;74;76;76;76;77;87;70;70 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;78;78;83;81;82;83;87;82;83 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;101;101;101;100;99;99;100;108;106 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;149;149;152;163;154;148;151;151;158;150 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;176;175;176;176;164;182;182;176;165 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;80;82;83;83;85;84;83;83;85 15:02:03 INFO - 2015-12-03 15:02:03,576 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:02:03 INFO - 2015-12-03 15:02:03,578 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:02:03 INFO - 2015-12-03 15:02:03,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,966 15:02:03 INFO - 2015-12-03 15:02:03,578 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:02:03 INFO - 2015-12-03 15:02:03,578 DEBUG : BROWSER_OUTPUT: __startTimestamp1449183723572__endTimestamp 15:02:03 INFO - 2015-12-03 15:02:03,579 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,579 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:02:03 INFO - 2015-12-03 15:02:03,579 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:02:03 INFO - 2015-12-03 15:02:03,579 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,579 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:133.60 Median:135.00 stddev:2.67 (2.0%) stddev-sans-first:2.26 15:02:03 INFO - 2015-12-03 15:02:03,580 DEBUG : BROWSER_OUTPUT: Values: 129.0 130.0 135.0 131.0 134.0 136.0 137.0 134.0 135.0 135.0 15:02:03 INFO - 2015-12-03 15:02:03,580 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,580 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:174.40 Median:184.00 stddev:16.30 (8.9%) stddev-sans-first:17.05 15:02:03 INFO - 2015-12-03 15:02:03,580 DEBUG : BROWSER_OUTPUT: Values: 182.0 156.0 193.0 190.0 160.0 186.0 153.0 188.0 181.0 155.0 15:02:03 INFO - 2015-12-03 15:02:03,580 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,581 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:197.40 Median:197.00 stddev:4.06 (2.1%) stddev-sans-first:3.59 15:02:03 INFO - 2015-12-03 15:02:03,581 DEBUG : BROWSER_OUTPUT: Values: 191.0 196.0 195.0 195.0 197.0 197.0 199.0 205.0 203.0 196.0 15:02:03 INFO - 2015-12-03 15:02:03,581 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,581 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.80 Median:85.00 stddev:37.36 (43.9%) stddev-sans-first:39.42 15:02:03 INFO - 2015-12-03 15:02:03,581 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 93.0 193.0 81.0 82.0 84.0 86.0 150.0 84.0 15:02:03 INFO - 2015-12-03 15:02:03,582 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,582 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.20 Median:117.50 stddev:21.94 (18.7%) stddev-sans-first:22.96 15:02:03 INFO - 2015-12-03 15:02:03,582 DEBUG : BROWSER_OUTPUT: Values: 115.0 120.0 164.0 112.0 114.0 112.0 150.0 106.0 105.0 154.0 15:02:03 INFO - 2015-12-03 15:02:03,582 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,582 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:144.30 Median:145.00 stddev:3.50 (2.4%) stddev-sans-first:3.57 15:02:03 INFO - 2015-12-03 15:02:03,584 DEBUG : BROWSER_OUTPUT: Values: 147.0 142.0 143.0 141.0 149.0 149.0 148.0 141.0 141.0 142.0 15:02:03 INFO - 2015-12-03 15:02:03,584 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,584 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.20 Median:153.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:02:03 INFO - 2015-12-03 15:02:03,584 DEBUG : BROWSER_OUTPUT: Values: 153.0 153.0 154.0 153.0 153.0 153.0 153.0 153.0 153.0 154.0 15:02:03 INFO - 2015-12-03 15:02:03,584 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,585 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:126.70 Median:128.50 stddev:2.98 (2.3%) stddev-sans-first:3.10 15:02:03 INFO - 2015-12-03 15:02:03,585 DEBUG : BROWSER_OUTPUT: Values: 125.0 123.0 129.0 130.0 129.0 124.0 124.0 124.0 128.0 131.0 15:02:03 INFO - 2015-12-03 15:02:03,585 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,585 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.20 Median:76.00 stddev:6.01 (7.9%) stddev-sans-first:5.12 15:02:03 INFO - 2015-12-03 15:02:03,585 DEBUG : BROWSER_OUTPUT: Values: 64.0 72.0 74.0 76.0 76.0 76.0 77.0 87.0 70.0 70.0 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:82.50 stddev:3.83 (4.6%) stddev-sans-first:2.76 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: Values: 73.0 78.0 78.0 83.0 81.0 82.0 83.0 87.0 82.0 83.0 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:100.80 Median:107.00 stddev:4.05 (3.8%) stddev-sans-first:3.16 15:02:03 INFO - 2015-12-03 15:02:03,586 DEBUG : BROWSER_OUTPUT: Values: 93.0 101.0 101.0 101.0 100.0 99.0 99.0 100.0 108.0 106.0 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:151.50 stddev:4.70 (3.1%) stddev-sans-first:4.81 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 152.0 163.0 154.0 148.0 151.0 151.0 158.0 150.0 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:176.00 stddev:8.63 (4.9%) stddev-sans-first:6.34 15:02:03 INFO - 2015-12-03 15:02:03,587 DEBUG : BROWSER_OUTPUT: Values: 155.0 176.0 175.0 176.0 176.0 164.0 182.0 182.0 176.0 165.0 15:02:03 INFO - 2015-12-03 15:02:03,588 DEBUG : BROWSER_OUTPUT: 15:02:03 INFO - 2015-12-03 15:02:03,588 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.20 Median:83.00 stddev:3.22 (3.9%) stddev-sans-first:1.54 15:02:03 INFO - 2015-12-03 15:02:03,588 DEBUG : BROWSER_OUTPUT: Values: 74.0 80.0 82.0 83.0 83.0 85.0 84.0 83.0 83.0 85.0 15:02:03 INFO - 2015-12-03 15:02:03,588 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:02:03 INFO - 2015-12-03 15:02:03,588 DEBUG : BROWSER_OUTPUT: 15:02:04 INFO - 2015-12-03 15:02:04,244 INFO : Browser exited with error code: 0 15:02:04 INFO - 2015-12-03 15:02:04,302 INFO : Completed test kraken (00:01:02) 15:02:04 INFO - 2015-12-03 15:02:04,302 INFO : Starting test v8_7 15:02:04 INFO - 2015-12-03 15:02:04,302 DEBUG : operating with platform_type : mac_ 15:02:04 INFO - 2015-12-03 15:02:04,302 INFO : Initialising browser for v8_7 test... 15:02:04 INFO - 2015-12-03 15:02:04,317 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp9BrfOA/profile http://localhost:49271/getInfo.html 15:02:06 INFO - 2015-12-03 15:02:06,726 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:02:06 INFO - 2015-12-03 15:02:06,727 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:02:06 INFO - 2015-12-03 15:02:06,727 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:02:06 INFO - 2015-12-03 15:02:06,727 DEBUG : BROWSER_OUTPUT: __metrics 15:02:06 INFO - 2015-12-03 15:02:06,743 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:07 INFO - 2015-12-03 15:02:07,447 INFO : Browser initialized. 15:02:07 INFO - 2015-12-03 15:02:07,447 INFO : Running cycle 1/1 for v8_7 test... 15:02:07 INFO - 2015-12-03 15:02:07,448 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp9BrfOA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:02:19 INFO - 2015-12-03 15:02:19,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 197894144 15:02:19 INFO - 2015-12-03 15:02:19,454 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 518709248 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: |0;Richards;212.04410517387618 15:02:42 INFO - 2015-12-03 15:02:42,645 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;236.12750885478158 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |2;Encrypt;381.38825324180016 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6986.111111111111 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1232.7586206896551 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |5;Earley;891.2655971479501 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |6;Boyer;15409.09090909091 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |7;RegExp;35258.620689655174 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |8;Splay;745.7121551081283 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6972.222222222223 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: __startTimestamp1449183762643__endTimestamp 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:02:42 INFO - 2015-12-03 15:02:42,646 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:212.04 Median:212.04 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: Values: 212.0 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:236.13 Median:236.13 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: Values: 236.1 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:381.39 Median:381.39 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: Values: 381.4 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6986.11 Median:6986.11 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: Values: 6986.1 15:02:42 INFO - 2015-12-03 15:02:42,647 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1232.76 Median:1232.76 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: Values: 1232.8 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:891.27 Median:891.27 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: Values: 891.3 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15409.09 Median:15409.09 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,648 DEBUG : BROWSER_OUTPUT: Values: 15409.1 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35258.62 Median:35258.62 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: Values: 35258.6 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:745.71 Median:745.71 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: Values: 745.7 15:02:42 INFO - 2015-12-03 15:02:42,649 DEBUG : BROWSER_OUTPUT: 15:02:42 INFO - 2015-12-03 15:02:42,650 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6972.22 Median:6972.22 stddev:0.00 (0.0%) 15:02:42 INFO - 2015-12-03 15:02:42,650 DEBUG : BROWSER_OUTPUT: Values: 6972.2 15:02:42 INFO - 2015-12-03 15:02:42,650 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:02:42 INFO - 2015-12-03 15:02:42,650 DEBUG : BROWSER_OUTPUT: 15:02:43 INFO - 2015-12-03 15:02:43,288 INFO : Browser exited with error code: 0 15:02:43 INFO - 2015-12-03 15:02:43,312 INFO : Completed test v8_7 (00:00:39) 15:02:43 INFO - 2015-12-03 15:02:43,338 INFO : Completed test suite (00:20:17) 15:02:43 INFO - 2015-12-03 15:02:43,338 DEBUG : Working with test: dromaeo_css 15:02:43 INFO - 2015-12-03 15:02:43,338 DEBUG : Generating results file: dromaeo_css 15:02:43 INFO - 2015-12-03 15:02:43,339 DEBUG : Working with test: kraken 15:02:43 INFO - 2015-12-03 15:02:43,339 DEBUG : Generating results file: kraken 15:02:43 INFO - 2015-12-03 15:02:43,339 INFO : javascript benchmark 15:02:43 INFO - 2015-12-03 15:02:43,339 DEBUG : Working with test: v8_7 15:02:43 INFO - 2015-12-03 15:02:43,339 DEBUG : Generating results file: v8_7 15:02:43 INFO - 2015-12-03 15:02:43,340 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:02:43 INFO - 2015-12-03 15:02:43,401 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 15:02:43 INFO - 2015-12-03 15:02:43,402 DEBUG : process_Request line: dromaeo_css 5864.49 graph.html#tests=[[72,52,55]] 15:02:43 INFO - 2015-12-03 15:02:43,402 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:02:43 INFO - 2015-12-03 15:02:43,433 DEBUG : process_Request line: kraken 1822.00 graph.html#tests=[[232,52,55]] 15:02:43 INFO - 2015-12-03 15:02:43,433 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:02:43 INFO - 2015-12-03 15:02:43,466 DEBUG : process_Request line: v8_7 16534.11 graph.html#tests=[[230,52,55]] 15:02:43 INFO - 2015-12-03 15:02:43,467 INFO : javascript benchmark 15:02:43 INFO - 2015-12-03 15:02:43,469 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [295.51978035692, 300.16703647378523, 304.45806464493205, 306.4193353594939, 311.4052160373686, 12697.365131743421, 13074.542391016317, 14490.637734056641, 14802.111873287611, 14860.777088343684, 13186.604401867959, 14725.410983560645, 15692.84307156931, 16285.267162977694, 16290.674186516262, 4472.239719247736, 4552.203364411214, 4567.92653726374, 4604.7927843247135, 4648.070385922829, 3486.0936156599214, 3553.5380400547892, 3559.305935342596, 4609.7234165949985, 4678.789454474557, 4847.466778654345, 5013.398392192942, 5024.497550244964, 5032.119379108642, 5048.0, 4892.461829198785, 4929.2359684248995, 4988.925166122511, 5032.043911656773, 5047.596192304625, 4371.803268852909, 4413.227685155085, 4419.0, 4431.645468362523, 4433.091216300683, 18802.717959230486, 19035.524111897175, 19058.047097645063, 19170.424887253404, 19271.325503607306, 1665.5419759566096, 1712.049812354143, 1718.9742153867703, 1753.2986805277862, 1985.662437385648, 11504.942475287653, 11718.296902185895, 11804.232724872942, 11838.230515016583, 12219.633410997685, 1425.7077299153752, 1447.5295528953027, 1458.585172382787, 1476.3725416697969, 1514.7803568482618, 50990.49009509895, 52777.73611131958, 53080.20379694346, 53096.469035309536, 53158.20262696063, 8085.757427277191, 8234.711785087493, 8774.692885749097, 8782.560871956377, 8869.512176830207, 10788.40663763485, 10804.729881752863, 10814.675559733221, 10817.513211905483, 10891.128709703205, 6898.068760717239, 6910.827229319308, 6932.306769323128, 6934.7226110955, 6945.548539344926, 6883.8967415488805, 6932.480063995221, 6956.234814170437, 6986.825329366807, 7057.647117644097, 5097.8725531862, 5102.132637451642, 5156.7421628919155, 5194.558462530727, 5212.348456442945, 1369.3153423288356, 1444.7688369860982, 1492.7984722062383, 1501.196859680066, 1507.8718308943644, 781.8319061401712, 838.7944953486435, 849.613425891218, 856.3320609924269, 879.8724184993268, 9514.714558563253, 9535.570899309549, 9597.28020398459, 14317.6420589484, 15475.922620386826, 367.9576848662438, 369.3444136657401, 389.2312682452191, 393.50614978202174, 408.4016915219218, 4924.384451943507, 5379.569634429236, 5397.3523177218985, 5514.172874068921, 5521.171824226398, 507172.0, 528788.0, 529284.0, 555608.0, 561305.0, 61239.38760612337, 61371.69314153401, 61926.0, 62132.68933655303, 62674.37325626777, 438.6337408264071, 442.3364952571079, 443.52542779225917, 445.4142802215077, 452.88451444881343, 8756.168164024408, 9020.729378118667, 9081.45511269326, 9320.72037838866, 9396.530173491436, 28686.713132869238, 28908.277293067, 29255.561166582094, 29395.11814645564, 29658.0, 40851.591484084776, 41014.79492602518, 41169.794151029055, 41385.79307103445, 41579.584204157574, 5508.228847961369, 11710.88289117132, 12056.0, 12058.216215945935, 12209.145359824726, 15082.54752357431, 15666.37334506607, 16262.837371626605, 16303.59241018984, 16566.17169141514, 9814.75463113428, 12701.4284357206, 13058.281794501014, 13087.541936032194, 13164.407601657756, 7308.659183114802, 7583.203763604963, 7715.768526944201, 12328.691782705504, 12411.813822792485, 8388.496690198608, 8460.788480288042, 8500.74497765068, 8517.95741021291, 8572.35707321941, 12303.0, 13111.40998655082, 13277.867221327662, 13690.45238190501, 13914.791278130633, 13260.204387736767, 13500.729985400041, 13648.727025459237, 13779.724405512034, 14115.01194916346], "dojo.html": [2602.2843717977553, 2664.8134630575855, 2667.1998400479865, 2671.9866400667993, 2700.203439985204, 4561.657875659326, 4564.338170965208, 4577.038821847416, 4592.701474404162, 4662.184117779392, 4584.404027476432, 4589.265717485203, 4596.0578081493295, 4623.4451865776155, 4653.232216684251, 4179.101493178973, 4214.515330736958, 4233.174530966463, 4271.252530807112, 4317.438732964726, 4058.6347228749405, 4066.2883995300854, 4086.346184610448, 4104.179164167179, 4105.0, 3807.8286477108595, 4045.887380970242, 4058.391241313797, 4097.9180416391655, 4113.300738874398, 4097.282975479294, 4134.400511925754, 4209.957900420987, 4241.427407300006, 4254.276772948575, 4163.812628431728, 4202.3696445533105, 4211.663066954667, 4241.151769646083, 4259.063006138645, 4301.65586753059, 4514.367988481616, 4536.296873984537, 4585.862424127282, 4589.288660257632, 4684.414448193976, 4782.521747825224, 4792.832250871203, 4822.059698358821, 4838.661293709441, 4838.661293709441, 4863.683860549053, 4879.56083952446, 4880.999395124027, 4920.4833492483485, 4406.62543683784, 4548.044910568785, 4560.110778398213, 4566.589006989387, 4577.5880170784785, 4947.406311242602, 4956.207006878882, 4992.625553083533, 5087.694738315713, 5090.6691065081395, 4811.3745213122775, 4855.732934688626, 4869.211074011373, 4878.95121048792, 4911.9754401227765, 4648.767561621906, 5013.799448022111, 5027.899442011139, 5029.195328747456, 5030.195168772979, 4581.198290299184, 4638.304254361873, 4682.812687492462, 4764.809407623726, 4807.230843065093, 4770.379850619397, 4800.543948324904, 4804.25534042224, 4811.78346974387, 4812.037592481448, 3641.380965235863, 3724.0689827543115, 3735.9252814943547, 3740.8129593520757, 3767.849286028583, 3341.74936879735, 3399.3201359728155, 3411.181316484026, 3415.7608967372544, 3435.038189306998, 4581.541845815392, 4584.4498660160325, 4595.195840727859, 4605.516420775837, 4607.562281583244, 4750.881227969328, 4929.433115191727, 4944.703317800943, 4949.802007919643, 4964.15609346412, 4459.620932220732, 4507.076049409863, 4509.684322097487, 4548.909021819545, 4586.954130458719, 4251.256030194703, 4306.504751953503, 4320.913581728348, 4358.956410435855, 4360.978195109004, 4689.718616882861, 4867.0995865764235, 4946.159152944008, 4948.703077815343, 4978.975105124451, 4756.8097276108565, 4934.087193869145, 4939.382577177853, 4941.33292005589, 4974.925376119289, 4971.37857767779, 5006.674566153189, 5009.273655319886, 5011.699298042129, 5069.5944324454695, 4746.501617330131, 4865.6107511398295, 4928.67963582366, 4929.9014019720125, 4959.256111583291, 4681.321208424827, 4700.623950084054, 4837.443693975097, 4844.563989240844, 4870.805167793249, 4784.7607619619575, 4816.494268101939, 4871.147549178809, 4890.266460031024, 4898.167311556973, 4479.216137176047, 4775.95224047769, 4842.903141937071, 4859.927101093415, 4867.050925069719, 4542.909141817079, 4666.160091183619, 4684.1334353144775, 4687.1328804171335, 4697.13103075932, 4790.473047964651, 4813.78337974799, 4844.878878028077, 4859.2954021667365, 4870.756462176806, 4518.390017347748, 4684.250519916797, 4722.787474563722, 4763.4522029967, 4793.952060479351], "mootools.html": [1132.6941725734048, 1451.3831621560835, 1503.353557970073, 1514.666773309872, 1555.774412710157, 5901.055831067025, 6148.631082135075, 6225.533085018619, 6363.300036995926, 6407.070974708665, 6412.615243085418, 6518.543701940866, 6524.249711283204, 6542.084108224841, 6643.534952553323, 1879.2670858365282, 1908.5419499320133, 1914.5692219250695, 1917.0798016951871, 1926.7206255093004, 1909.2744756992324, 1912.9808701912941, 1938.8836669799857, 1944.572194117292, 1949.6393167264102, 1898.1837809741805, 1926.4509614759797, 1935.912883920227, 1943.4072607854598, 1944.1931598386652, 1825.8904465732032, 1886.518937670892, 1889.3576184097474, 1897.8197071278344, 1902.9333973310936, 1836.6785812482763, 1881.9247230110916, 1888.8488920886296, 1889.962200755991, 1928.884266943974, 5885.8822823543715, 6403.263624683174, 6416.165898433221, 6422.871542569169, 6465.3857883501, 3726.496922915399, 3786.3752480840626, 3895.162540053902, 4045.3325201341745, 4052.9797351013353, 2427.2718184544565, 2521.747825217482, 2546.6689330387117, 2547.1339744486777, 2569.2677586887835, 727.5089314712601, 741.6291854072964, 755.5267228903659, 762.306301265851, 766.7048186448202, 8439.0, 8536.402451828375, 8574.785630359229, 8594.226519613265, 8663.74008779744, 3595.1371670799344, 3624.9637503624626, 3689.2990331836863, 3719.702423806089, 3723.255348930225, 7549.886751698729, 7605.353544948742, 7647.961760191163, 7712.691492340244, 7725.343345815556, 4013.538443079025, 4083.0813067059676, 4088.8160032798596, 4112.383142528644, 4145.046639272984, 3716.8699095532065, 3720.720945929066, 3744.868929587506, 3753.9061523462133, 3760.022394177479, 2992.9102126936227, 3015.562743402238, 3058.3271680230314, 3075.0, 3101.286704058079, 953.2278854128178, 969.7866469376726, 971.0726256425097, 972.0959507657946, 994.8955359687128, 852.8550146475114, 893.5755516129786, 897.1028971028971, 902.0483390023458, 984.3306551544875, 6077.4834139098675, 6166.753329866845, 6179.721912513947, 6199.969000154971, 6238.1266622672865, 957.3872721458272, 994.8358520844124, 996.7906739584623, 1015.4516561056946, 1018.9796204075877, 4579.74811385377, 4839.443464001614, 4873.488283730228, 4885.5847252983185, 4911.705297682151, 7082.29177082298, 7392.1499027611435, 7500.662470188855, 7615.2865605239485, 7635.31282184595, 7447.739329123455, 7478.439117066133, 7500.962495187489, 7502.887456688154, 7510.248975102555, 5954.136650185699, 5973.910391344133, 6044.153818465418, 6100.48145907594, 6158.907616385758, 6169.475594574512, 6186.1339412483185, 6189.81430557084, 6209.254889413119, 6253.062040693932, 6778.389944904785, 6850.520463567702, 6926.238113807376, 6955.791326260221, 6986.231514533296, 6929.653517324215, 7066.04608377883, 7134.2152363238965, 7150.5352152109945, 7164.820879478055, 5835.978703726916, 5874.823755287348, 5877.265341832271, 5898.4101589840675, 5905.911411328748, 6167.907481387872, 6203.069539569101, 6260.123582698517, 6265.028920517327, 6266.310705822447, 5768.913466298093, 5788.0, 5887.326185124176, 5901.734421951109, 5911.615744976562, 5538.556915446674, 5707.315122185364, 5749.913751293818, 5763.991301522301, 5891.970540147272, 5829.3296270927685, 5880.794172203952, 5898.203742494708, 5917.260342457193, 5923.822285331447, 5259.815906443409, 5332.22682710997, 5407.486288802715, 5408.702521361363, 5434.64674796137, 5353.384360798403, 5374.543163831118, 5486.286782718221, 5493.560515158698, 5506.201600767786], "ext.html": [468.4753076554259, 476.98640389173005, 479.0658216477868, 480.2124515794096, 507.25940127413975, 26878.19365419038, 27546.0, 32559.1860203495, 32955.340893182125, 33154.33691326178, 35330.64669353305, 35403.29193416137, 35526.8223658882, 35613.46579801305, 35627.10932226696, 7085.787426377217, 7711.961440192791, 7899.091604465502, 7899.881501777478, 7906.604669766518, 7233.348998590126, 9176.220021298164, 9425.387349822275, 9456.527173641325, 9488.762780930463, 9215.262778977665, 9372.531373431335, 9372.531373431335, 9441.716748497556, 9464.290178236626, 7361.889571656429, 7547.28300811422, 9176.632934682604, 9276.304277179239, 9417.105374989365, 9008.459492430475, 9227.53862306882, 9267.351285410025, 9319.487428191447, 9354.812903741888, 32770.344593108006, 33194.50208246854, 33446.83276583626, 33601.83199084013, 33690.1577460563, 2510.3222130024974, 2514.421683012917, 2590.235880415282, 2865.6704478984975, 2876.3528206153655, 22471.438214044618, 23093.0, 23353.416164595852, 23915.04339826422, 24079.759202407928, 1900.2114122639089, 1922.9903850480657, 1959.8922059286733, 1971.0834461975107, 2006.3178519303508, 244569.0, 245784.99999999822, 247419.0, 251426.0, 251970.0, 46348.536514635096, 47497.0, 49483.25775113376, 49970.50029499731, 53767.19349209765, 49884.50115498871, 50304.74847625739, 50553.0, 50777.0, 51374.22938655923, 14114.435422582981, 14399.352029158714, 14428.927855360656, 14435.206063666388, 14567.92716036413, 10924.508397122148, 10943.398113103696, 11021.559137634405, 11078.778424431466, 11148.219624626197, 15896.364145434285, 16009.439669611507, 16178.59553511148, 16256.593585160466, 16340.67318653644, 6718.160229971254, 6903.344182302673, 6973.302669732986, 6983.196932352845, 7019.333163349474, 778.1906816910463, 792.4413288631501, 838.149278482341, 883.0948278014957, 937.4515908193647, 21721.782782172293, 22106.33680989573, 22262.219022478163, 22323.776762232494, 22366.217182398537, 874.8862647855738, 936.1761649748178, 950.6387572722322, 1031.9380837149795, 1079.5951518180682, 9051.909480905239, 10315.27793054479, 11781.587644432404, 11825.52697892092, 11861.229020113666, 288303.0, 290861.0, 291396.0, 291494.0, 294774.0, 38829.41755873664, 39898.40152397716, 45104.3234351485, 45384.0, 45400.77299613481, 1168.1122347016328, 1188.506769690586, 1199.5022065842752, 1211.9091068169923, 1216.2033867816594, 22933.65599516042, 23106.422339440975, 23890.88054559716, 24252.393690157885, 24276.51446971086, 36900.26199476049, 37498.25003499969, 37918.0, 42594.14811703811, 43118.0, 188136.0, 188480.0, 189737.0, 192221.0, 192401.0, 26120.216393508224, 26135.73864261409, 27035.459290814466, 27056.917723291634, 27059.323516912234, 33733.3253334927, 33991.0, 34580.82709586436, 34650.13374665654, 35104.648953510135, 27786.16641500758, 28528.42943141084, 28648.0, 28688.28279292951, 28691.426171476036, 29103.85448072746, 29271.70728292775, 29372.55941160927, 29544.113676589735, 29594.96417625373, 30056.549151763178, 30184.24539386445, 30305.69694303117, 30384.5442318361, 30397.848010759804, 24896.751032489443, 25480.362990925376, 25714.742852571235, 26081.217563473125, 26385.472290554466, 18948.336808211647, 19686.60626787485, 19882.60234795267, 20095.296664616668, 20991.0], "prototype.html": [265.9946801063979, 272.4632474026168, 276.09441033410417, 281.53125046797084, 287.2588721099563, 5151.995360904625, 5172.586193104552, 5193.844184674461, 5230.21546767985, 5236.73816309184, 5023.422306434761, 5026.9497305026935, 5092.974535127329, 5121.590272778178, 5166.638335316529, 3946.289667859784, 3960.623740744632, 3974.7615143091507, 3976.542697589771, 3982.8406863725418, 3843.4811300474357, 3883.864064757734, 3913.6869050476034, 3941.60583941605, 3985.083430810915, 3870.651641352292, 3878.8448462061483, 3939.862104826317, 3942.349512330462, 3984.0836607580272, 3909.4135879618, 3917.3928041153667, 3922.8234729437245, 3938.0154961259686, 3963.0686788604653, 3402.5066365376883, 3417.4361230396953, 3429.6741809528053, 3456.5679290088738, 3469.826508674556, 4776.11641846256, 4909.509049095098, 4932.112219800434, 4976.552110310089, 4997.575206107485, 4368.148211098837, 4497.572730590588, 4501.977490112561, 4543.0459603483305, 4543.931841022388, 5333.35999680037, 5355.518003379714, 5434.728263586844, 5440.183972404171, 5446.074167391553, 3572.1248294168095, 3654.488371627948, 3718.200586873808, 3764.9058773530605, 3828.712846536521, 5438.510534051915, 5493.450654934514, 5532.28080349552, 5558.221848941152, 5577.776888924438, 3786.5077539919635, 3791.184895247535, 3804.885853424402, 3804.961950380516, 3816.0, 3835.6356146166067, 3855.5373355197557, 3864.091938394475, 3891.455196272524, 3912.0, 4350.0, 4423.845165419195, 4431.423914891044, 4432.667549933768, 4488.842890498817, 5366.490183432567, 5392.595555333287, 5429.131338985743, 5455.699936503531, 5458.935507576064, 1392.9930350348184, 1402.4179965314484, 1407.9577612671637, 1416.95040673578, 1430.106183635228, 905.542700936023, 905.5970093308546, 910.3672947301694, 941.204682043672, 941.5151197133482, 4971.950280497221, 5029.1953287473825, 5120.8719782005, 5126.051680439131, 5143.614228932845, 5506.1190209566275, 5586.078297081018, 5595.8601034973635, 5611.2144299798065, 5616.466435688603, 5034.924476132861, 5099.082165210298, 5099.949000509948, 5126.769295381717, 5129.461406552333, 3028.3337665713507, 3079.5072788353755, 3100.5969224001187, 3106.673799251046, 3109.673484284163, 5689.459501347448, 5689.6586204827845, 5703.17303990919, 5726.627769194989, 5736.053551164095, 5747.425257474303, 5778.3354914184565, 5782.306123265235, 5810.157527158538, 5853.970730146407, 5683.687397193194, 5687.829365118971, 5711.7144142792695, 5736.6558006519745, 5808.041673123887, 5498.202760599771, 5607.859803504945, 5624.943750562442, 5689.374168841341, 5721.914171287351, 5473.2063850742215, 5503.834884953458, 5542.9168562472405, 5557.305336832896, 5623.943760562342, 5520.696361700145, 5556.083246264483, 5559.52744016747, 5641.661500309994, 5719.799807006735, 3681.8527258910417, 3699.6300369962787, 3718.8140592969703, 3746.9063273418383, 3758.2671379080816, 5539.975104605661, 5570.721463926869, 5574.498295153456, 5575.693336866511, 5613.410591887956, 5255.185446255837, 5426.70153141581, 5448.291722076105, 5494.36814766291, 5494.752736126964, 5546.4453554644215, 5560.2493663356545, 5580.972095139498, 5583.748731307182, 5603.495685388335, 5369.97315013438, 5376.435474275145, 5391.595630327663, 5407.107827208624, 5475.945240547543, 5498.285222920995, 5502.889942201214, 5514.834554963358, 5564.360098588714, 5581.330240371181, 5236.659617124875, 5387.838364849061, 5390.892182156414, 5401.945980540144, 5450.91823622638], "yui.html": [548.5803360429272, 559.6586082489681, 576.6511260687284, 616.1374076293192, 645.6448953075809, 11350.886491135087, 11963.521459141624, 11965.940170299158, 11974.580889668863, 12008.339541325224, 11828.940855295734, 12075.765983293097, 12091.697707557294, 12099.032077433807, 12222.572209972654, 598.7096258314714, 601.4917394801386, 711.6655172069133, 733.9596322202277, 741.2069086077898, 758.5827794712914, 770.8072981754561, 780.6174974262627, 781.4061313401827, 782.3428320211021, 776.1307335783902, 782.2607635784186, 785.0775338976708, 790.9841803163933, 797.7487091566167, 629.7701339011273, 649.7011374767612, 762.7330434347989, 779.5712358203023, 813.9633716482742, 584.2784161560469, 587.1632923084587, 592.8606777407306, 594.5035895027657, 597.4145337569163, 11862.466189021514, 11905.940470297679, 11915.523379064827, 12042.69893252667, 12095.21381110225, 9877.209823214125, 9901.0, 10099.495025248782, 10394.688159355232, 10803.945980270128, 7721.691132354699, 7774.0, 7793.454458187873, 8011.399145064085, 8253.95873020637, 2820.9435811283865, 2860.0561814601133, 2866.5270230411957, 2913.2716820794803, 2956.793024488287, 39960.20079598392, 40550.79724601358, 40988.79505602483, 41221.79389103036, 41452.37821432681, 7838.752508261021, 7897.24976127267, 8013.198680132056, 8106.837863242702, 8173.060098088796, 16937.745933811002, 16947.915260423866, 17044.744328835077, 17058.402955896483, 17171.484855454357, 5658.377578466366, 5823.505002074871, 5919.408059194132, 5976.133460648181, 6118.265808103056, 3167.2715275486767, 3236.093893709765, 3337.249118948217, 3343.1809206744015, 3418.247985443248, 2751.9036833710725, 2775.9444811103663, 2778.263760103574, 2780.708025657317, 2790.6651201855907, 375.28133624109523, 394.54627178744676, 396.1206122408249, 397.52892822006015, 484.1478996965366, 455.703792534855, 486.95373939475695, 487.6903166489234, 497.19702680171264, 515.1757188498448, 6188.907166392508, 6246.0, 6414.262359828586, 6496.155499784998, 6573.375529324802, 509.4574278393499, 513.117438006628, 513.1968469345537, 524.9947500524946, 536.8792021795143, 2886.985565072161, 3219.8390080495883, 3274.5251938468787, 3291.4240007998983, 3362.2434952136064, 53884.46115538873, 53900.0, 54656.72671636617, 54844.33823125079, 54849.725751370985, 45743.54256457393, 46847.76576117097, 46873.76563117231, 46885.76557117193, 46944.295835562494, 41731.791341042495, 42085.1582968345, 42766.78616606959, 43056.3541546877, 43572.346414803804, 6624.171978502687, 6665.866682666223, 6735.595864248161, 6781.898271525833, 7075.752348667772, 29937.0, 29949.251268718457, 31349.529757053206, 32120.839395802872, 32128.839355803073, 38059.0, 38077.238455231294, 38143.42784858174, 39930.20139597134, 41410.79294603508, 6183.783567575293, 6200.503959683305, 6379.649119298483, 6795.762148324785, 6893.620850853251, 9307.395019323721, 9501.904980950101, 9671.0, 9754.707358779247, 9953.950230248802, 8631.0, 8804.163604457566, 8843.0, 8843.646254150019, 9121.543922803967, 8729.869051964099, 8821.117888211384, 9194.448333100036, 9320.906790932275, 9510.38182518134, 8597.226249637562, 8620.741377758677, 8710.69512567057, 8871.112888711335, 9306.488143152192, 7368.815779605553, 7418.851622967402, 7591.4685971983645, 7615.847683046419, 7888.802779930547, 7118.786436406916, 7521.623918803928, 7544.811379715551, 7616.428767842544, 7670.846583068196]}, "summary": {"suite": 5864.488484703153, "subtests": {"jquery.html": {"filtered": 7324.822911350823, "value": 7324.822911350823}, "dojo.html": {"filtered": 4494.193256251941, "value": 4494.193256251941}, "mootools.html": {"filtered": 3743.20552766811, "value": 3743.20552766811}, "ext.html": {"filtered": 15532.150877599557, "value": 15532.150877599557}, "prototype.html": {"filtered": 4084.730341727432, "value": 4084.730341727432}, "yui.html": {"filtered": 5202.929384974427, "value": 5202.929384974427}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449182545, "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": "20151203130049", "branch": "Mozilla-Aurora", "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f"}}, {"talos_counters": {}, "results": {"audio-dft": [191.0, 196.0, 195.0, 195.0, 197.0, 197.0, 199.0, 205.0, 203.0, 196.0], "ai-astar": [129.0, 130.0, 135.0, 131.0, 134.0, 136.0, 137.0, 134.0, 135.0, 135.0], "imaging-gaussian-blur": [147.0, 142.0, 143.0, 141.0, 149.0, 149.0, 148.0, 141.0, 141.0, 142.0], "audio-beat-detection": [182.0, 156.0, 193.0, 190.0, 160.0, 186.0, 153.0, 188.0, 181.0, 155.0], "json-stringify-tinderbox": [73.0, 78.0, 78.0, 83.0, 81.0, 82.0, 83.0, 87.0, 82.0, 83.0], "stanford-crypto-pbkdf2": [155.0, 176.0, 175.0, 176.0, 176.0, 164.0, 182.0, 182.0, 176.0, 165.0], "json-parse-financial": [64.0, 72.0, 74.0, 76.0, 76.0, 76.0, 77.0, 87.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [74.0, 80.0, 82.0, 83.0, 83.0, 85.0, 84.0, 83.0, 83.0, 85.0], "audio-fft": [93.0, 92.0, 93.0, 193.0, 81.0, 82.0, 84.0, 86.0, 150.0, 84.0], "imaging-darkroom": [153.0, 153.0, 154.0, 153.0, 153.0, 153.0, 153.0, 153.0, 153.0, 154.0], "stanford-crypto-ccm": [149.0, 149.0, 152.0, 163.0, 154.0, 148.0, 151.0, 151.0, 158.0, 150.0], "audio-oscillator": [115.0, 120.0, 164.0, 112.0, 114.0, 112.0, 150.0, 106.0, 105.0, 154.0], "stanford-crypto-aes": [93.0, 101.0, 101.0, 101.0, 100.0, 99.0, 99.0, 100.0, 108.0, 106.0], "imaging-desaturate": [125.0, 123.0, 129.0, 130.0, 129.0, 124.0, 124.0, 124.0, 128.0, 131.0]}, "summary": {"suite": 1822.0000000000002, "subtests": {"audio-fft": {"filtered": 103.8, "value": 103.8}, "stanford-crypto-pbkdf2": {"filtered": 172.7, "value": 172.7}, "audio-beat-detection": {"filtered": 174.4, "value": 174.4}, "stanford-crypto-ccm": {"filtered": 152.5, "value": 152.5}, "imaging-darkroom": {"filtered": 153.2, "value": 153.2}, "json-parse-financial": {"filtered": 74.2, "value": 74.2}, "audio-oscillator": {"filtered": 125.2, "value": 125.2}, "ai-astar": {"filtered": 133.6, "value": 133.6}, "audio-dft": {"filtered": 197.4, "value": 197.4}, "stanford-crypto-sha256-iterative": {"filtered": 82.2, "value": 82.2}, "json-stringify-tinderbox": {"filtered": 81.0, "value": 81.0}, "imaging-gaussian-blur": {"filtered": 144.3, "value": 144.3}, "stanford-crypto-aes": {"filtered": 100.8, "value": 100.8}, "imaging-desaturate": {"filtered": 126.7, "value": 126.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449182545, "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": "20151203130049", "branch": "Mozilla-Aurora", "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [236.12750885478158], "Encrypt": [381.38825324180016], "NavierStokes": [6972.222222222223], "Decrypt": [6986.111111111111], "Splay": [745.7121551081283], "Richards": [212.04410517387618], "RegExp": [35258.620689655174], "Earley": [891.2655971479501], "Boyer": [15409.09090909091], "RayTrace": [1232.7586206896551]}, "summary": {"suite": 16534.10951292166, "subtests": {"DeltaBlue": {"filtered": 280.00973, "value": 280.00973}, "Encrypt": {"filtered": 697.9265819999998, "value": 697.9265819999998}, "NavierStokes": {"filtered": 212.8446215139441, "value": 212.8446215139441}, "Decrypt": {"filtered": 38.10145526838965, "value": 38.10145526838965}, "Splay": {"filtered": 109.27943099999997, "value": 109.27943099999997}, "RegExp": {"filtered": 25.837227383863073, "value": 25.837227383863073}, "Richards": {"filtered": 166.48423200000002, "value": 166.48423200000002}, "Earley": {"filtered": 747.7714859999999, "value": 747.7714859999999}, "Boyer": {"filtered": 43.251286135693185, "value": 43.251286135693185}, "RayTrace": {"filtered": 600.2707972027974, "value": 600.2707972027974}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0101"}, "testrun": {"date": 1449182545, "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": "20151203130049", "branch": "Mozilla-Aurora", "revision": "7303f043cf7e4ebd20ce072d33ed4a92495f503f"}}] 15:02:43 INFO - RETURN: dromaeo_css: 5864.49 15:02:43 INFO - RETURN: kraken: 1822.00 15:02:43 INFO - RETURN: v8_7: 16534.11 15:02:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "16534.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1822.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "5864.49"}}} 15:02:43 INFO - Return code: 0 15:02:43 INFO - # TBPL SUCCESS # 15:02:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:02:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:02:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:02:43 INFO - 2015-12-03 15:02:43.607 screenresolution[1653:9742] starting screenresolution argv=screenresolution get 15:02:43 INFO - 2015-12-03 15:02:43.611 screenresolution[1653:9742] Display 0: 1600x1200x32@60 15:02:43 INFO - 2015-12-03 15:02:43.618 screenresolution[1654:9746] starting screenresolution argv=screenresolution list 15:02:43 INFO - Available Modes on Display 0 15:02:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:02:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:02:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:02:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:02:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:02:43 INFO - Intel HD Graphics 3000: 15:02:43 INFO - Chipset Model: Intel HD Graphics 3000 15:02:43 INFO - Type: GPU 15:02:43 INFO - Bus: Built-In 15:02:43 INFO - VRAM (Total): 512 MB 15:02:43 INFO - VRAM (Dynamic, Max): 10 15:02:43 INFO - Vendor: Intel (0x8086) 15:02:43 INFO - Device ID: 0x0116 15:02:43 INFO - Revision ID: 0x0009 15:02:43 INFO - Displays: 15:02:43 INFO - Display: 15:02:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:02:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:02:43 INFO - Display Serial Number: 1600x1200 60 15:02:43 INFO - Main Display: Yes 15:02:43 INFO - Mirror: Off 15:02:43 INFO - Online: Yes 15:02:43 INFO - Rotation: Supported 15:02:43 INFO - Return code: 0 15:02:43 INFO - Running post-action listener: _resource_record_post_action 15:02:43 INFO - Running post-run listener: _resource_record_post_run 15:02:44 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 37303296; Write bytes: 678906880; Read time: 4083; Write time: 41309 15:02:44 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 334660096; Write bytes: 334804992; Read time: 37168; Write time: 5020 15:02:45 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 36373504; Write bytes: 333833216; Read time: 3757; Write time: 34338 15:02:45 INFO - Running post-run listener: _upload_blobber_files 15:02:45 INFO - Blob upload gear active. 15:02:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:02:45 INFO - Copying logs to upload dir... 15:02:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.049905 ========= master_lag: 59.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 5 secs) (at 2015-12-03 15:03:44.492845) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 15:03:44.496439) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/Z7yDKVmhSvWNjj9PiTCYCA/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.33 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 15:03:44.833705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:03:44.834034) ========= 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.iAxEt6H70B/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.soSherLr07/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/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.005446 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:03:44.961840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 15:03:44.962195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 15:03:44.965495) ========= ========= Total master_lag: 60.01 =========