builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0080 starttime: 1447085600.76 results: success (0) buildid: 20151109055233 builduid: ac1be83046d54aa8a27e9dd3094d9e93 revision: cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:20.756407) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:20.757124) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:20.757411) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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.006180 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:20.799054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2015-11-09 08:13:20.799328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2015-11-09 08:13:33.766315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:33.766561) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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.005496 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:33.820114) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:33.820388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:33.820786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-09 08:13:33.821062) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-09 08:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-09 08:13:34 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.319958 ========= master_lag: 3.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-09 08:13:37.380019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:37.380429) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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.019879 ========= master_lag: 0.70 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 08:13:38.104255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-09 08:13:38.104567) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 --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 cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-09 08:13:38,219 truncating revision to first 12 chars 2015-11-09 08:13:38,219 Setting DEBUG logging. 2015-11-09 08:13:38,219 attempt 1/10 2015-11-09 08:13:38,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cafe4b776cac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 08:13:38,500 unpacking tar archive at: mozilla-aurora-cafe4b776cac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528962 ========= master_lag: 2.74 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-11-09 08:13:41.378494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 27 secs) (at 2015-11-09 08:13:41.378797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 27 secs) (at 2015-11-09 08:14:08.616973) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 08:14:08.617333) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 08:14:08.620924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 51 secs) (at 2015-11-09 08:14:08.621318) ========= /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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:09 INFO - MultiFileLogger online at 20151109 08:14:09 in /builds/slave/test 08:14:09 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 08:14:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:09 INFO - {'append_to_log': False, 08:14:09 INFO - 'base_work_dir': '/builds/slave/test', 08:14:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:09 INFO - 'branch': 'Mozilla-Aurora', 08:14:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:09 INFO - 'config_files': ('talos/mac_config.py',), 08:14:09 INFO - 'default_actions': ('clobber', 08:14:09 INFO - 'read-buildbot-config', 08:14:09 INFO - 'download-and-extract', 08:14:09 INFO - 'populate-webroot', 08:14:09 INFO - 'create-virtualenv', 08:14:09 INFO - 'install', 08:14:09 INFO - 'run-tests'), 08:14:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:09 INFO - 'download_minidump_stackwalk': True, 08:14:09 INFO - 'download_symbols': 'ondemand', 08:14:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:09 INFO - 'installer_path': 'installer.exe', 08:14:09 INFO - 'log_level': 'info', 08:14:09 INFO - 'log_name': 'talos', 08:14:09 INFO - 'log_to_console': True, 08:14:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:14:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:14:09 INFO - 'opt_config_files': (), 08:14:09 INFO - 'pip_index': False, 08:14:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:09 INFO - 'cmd': ('bash', 08:14:09 INFO - '-c', 08:14:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:09 INFO - 'enabled': True, 08:14:09 INFO - 'halt_on_failure': False, 08:14:09 INFO - 'name': 'check_screen_resolution'},), 08:14:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:14:09 INFO - 'cmd': ('bash', 08:14:09 INFO - '-c', 08:14:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:14:09 INFO - 'enabled': True, 08:14:09 INFO - 'halt_on_failure': False, 08:14:09 INFO - 'name': 'check_screen_resolution'},), 08:14:09 INFO - 'run_cmd_checks_enabled': True, 08:14:09 INFO - 'sps_profile': False, 08:14:09 INFO - 'sps_profile_interval': 0, 08:14:09 INFO - 'suite': 'dromaeojs', 08:14:09 INFO - 'system_bits': '64', 08:14:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:09 INFO - 'title': 't-yosemite-r5-0080', 08:14:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:09 INFO - 'use_talos_json': True, 08:14:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:09 INFO - 'work_dir': 'build'} 08:14:09 INFO - ##### 08:14:09 INFO - ##### Running clobber step. 08:14:09 INFO - ##### 08:14:09 INFO - Running pre-action listener: _resource_record_pre_action 08:14:09 INFO - Running main action method: clobber 08:14:09 INFO - rmtree: /builds/slave/test/build 08:14:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:11 INFO - Running post-action listener: _resource_record_post_action 08:14:11 INFO - ##### 08:14:11 INFO - ##### Running read-buildbot-config step. 08:14:11 INFO - ##### 08:14:11 INFO - Running pre-action listener: _resource_record_pre_action 08:14:11 INFO - Running main action method: read_buildbot_config 08:14:11 INFO - Using buildbot properties: 08:14:11 INFO - { 08:14:11 INFO - "properties": { 08:14:11 INFO - "buildnumber": 258, 08:14:11 INFO - "product": "firefox", 08:14:11 INFO - "script_repo_revision": "production", 08:14:11 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 08:14:11 INFO - "repository": "", 08:14:11 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 08:14:11 INFO - "buildid": "20151109055233", 08:14:11 INFO - "slavename": "t-yosemite-r5-0080", 08:14:11 INFO - "pgo_build": "False", 08:14:11 INFO - "basedir": "/builds/slave/test", 08:14:11 INFO - "project": "", 08:14:11 INFO - "platform": "yosemite", 08:14:11 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:14:11 INFO - "slavebuilddir": "test", 08:14:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:14:11 INFO - "branch": "mozilla-aurora", 08:14:11 INFO - "repo_path": "releases/mozilla-aurora", 08:14:11 INFO - "stage_platform": "macosx64", 08:14:11 INFO - "builduid": "ac1be83046d54aa8a27e9dd3094d9e93", 08:14:11 INFO - "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7" 08:14:11 INFO - }, 08:14:11 INFO - "sourcestamp": { 08:14:11 INFO - "repository": "", 08:14:11 INFO - "hasPatch": false, 08:14:11 INFO - "project": "", 08:14:11 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:14:11 INFO - "changes": [ 08:14:11 INFO - { 08:14:11 INFO - "category": null, 08:14:11 INFO - "files": [ 08:14:11 INFO - { 08:14:11 INFO - "url": null, 08:14:11 INFO - "name": "https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 08:14:11 INFO - } 08:14:11 INFO - ], 08:14:11 INFO - "repository": "", 08:14:11 INFO - "rev": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7", 08:14:11 INFO - "who": "cbook@mozilla.com", 08:14:11 INFO - "when": 1447084882, 08:14:11 INFO - "number": 6637682, 08:14:11 INFO - "comments": "Bug 1209994 - Take block-wrapper path only for blocks that are wrappers. r=bz, a=sylvestre", 08:14:11 INFO - "project": "", 08:14:11 INFO - "at": "Mon 09 Nov 2015 08:01:22", 08:14:11 INFO - "branch": "mozilla-aurora-macosx64-talos", 08:14:11 INFO - "revlink": "", 08:14:11 INFO - "properties": [ 08:14:11 INFO - [ 08:14:11 INFO - "buildid", 08:14:11 INFO - "20151109055233", 08:14:11 INFO - "Change" 08:14:11 INFO - ], 08:14:11 INFO - [ 08:14:11 INFO - "builduid", 08:14:11 INFO - "ac1be83046d54aa8a27e9dd3094d9e93", 08:14:11 INFO - "Change" 08:14:11 INFO - ], 08:14:11 INFO - [ 08:14:11 INFO - "pgo_build", 08:14:11 INFO - "False", 08:14:11 INFO - "Change" 08:14:11 INFO - ] 08:14:11 INFO - ], 08:14:11 INFO - "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7" 08:14:11 INFO - } 08:14:11 INFO - ], 08:14:11 INFO - "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7" 08:14:11 INFO - } 08:14:11 INFO - } 08:14:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 08:14:11 INFO - Running post-action listener: _resource_record_post_action 08:14:11 INFO - ##### 08:14:11 INFO - ##### Running download-and-extract step. 08:14:11 INFO - ##### 08:14:11 INFO - Running pre-action listener: _resource_record_pre_action 08:14:11 INFO - Running main action method: download_and_extract 08:14:11 INFO - mkdir: /builds/slave/test/build/tests 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:11 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/test_packages.json 08:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/test_packages.json 08:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:14:12 INFO - Downloaded 1149 bytes. 08:14:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:14:12 INFO - Using the following test package requirements: 08:14:12 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:14:12 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 08:14:12 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'jsshell-mac.zip'], 08:14:12 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 08:14:12 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:14:12 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 08:14:12 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 08:14:12 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 08:14:12 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 08:14:12 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 08:14:12 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 08:14:12 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:14: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')]} 08:14:12 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:13 INFO - Downloaded 17445959 bytes. 08:14:13 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 08:14:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:14:18 INFO - Return code: 0 08:14:18 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 08:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:18 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:14:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:19 INFO - Downloaded 17445959 bytes. 08:14:19 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 08:14:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 08:14:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 08:14:24 INFO - Return code: 0 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:24 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:14:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:14:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:14:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:26 INFO - Downloaded 11131307 bytes. 08:14:26 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 08:14:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 08:14:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:14:26 INFO - Return code: 0 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:26 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 08:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:30 INFO - Downloaded 107727982 bytes. 08:14:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:14:30 INFO - mkdir: /builds/slave/test/properties 08:14:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:30 INFO - Contents: 08:14:30 INFO - build_url:https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 08:14:30 INFO - Running post-action listener: _resource_record_post_action 08:14:30 INFO - Running post-action listener: set_extra_try_arguments 08:14:30 INFO - ##### 08:14:30 INFO - ##### Running populate-webroot step. 08:14:30 INFO - ##### 08:14:30 INFO - Running pre-action listener: _resource_record_pre_action 08:14:30 INFO - Running main action method: populate_webroot 08:14:30 INFO - Guessing talos json url... 08:14:30 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')]} 08:14:30 INFO - https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 08:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 08:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nqR-yertQM-6oluP3M94vw/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 08:14:30 INFO - Downloaded 107 bytes. 08:14:30 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 08:14:30 INFO - Contents: 08:14:30 INFO - 20151109055233 08:14:30 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 08:14:30 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')]} 08:14:30 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cafe4b776c/testing/talos/talos.json 08:14:30 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cafe4b776c/testing/talos/talos.json to /builds/slave/test/build/talos.json 08:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/cafe4b776c/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 08:14:31 INFO - Downloaded 4264 bytes. 08:14:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:14:31 INFO - '../fennec_ids.txt'], 08:14:31 INFO - 'tests': ['tcheck2']}, 08:14:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:31 INFO - '--tppagecycles', 08:14:31 INFO - '7'], 08:14:31 INFO - 'tests': ['tsvgm']}}, 08:14:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:14:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:14:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:14:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['damp', 'tps']}, 08:14:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['damp', 'tps']}, 08:14:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:14:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:31 INFO - 'other': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'other_l64': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'other_nol64': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore']}, 08:14:31 INFO - 'svgr': {'tests': ['tsvgx', 08:14:31 INFO - 'tsvgr_opacity', 08:14:31 INFO - 'tart', 08:14:31 INFO - 'tscrollx', 08:14:31 INFO - 'cart']}, 08:14:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['tsvgx', 08:14:31 INFO - 'tsvgr_opacity', 08:14:31 INFO - 'tart', 08:14:31 INFO - 'tscrollx', 08:14:31 INFO - 'cart']}, 08:14:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['tp5o']}, 08:14:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--e10s'], 08:14:31 INFO - 'tests': ['tp5o']}, 08:14:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--xperf_path', 08:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:31 INFO - 'tests': ['tp5n']}, 08:14:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--e10s', 08:14:31 INFO - '--xperf_path', 08:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 08:14:31 INFO - 'C:/slave/talos-data/talos/xperf.config'], 08:14:31 INFO - 'tests': ['tp5n']}}, 08:14:31 INFO - 'talos.zip': {'path': '', 08:14:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:31 INFO - Running post-action listener: _resource_record_post_action 08:14:31 INFO - ##### 08:14:31 INFO - ##### Running create-virtualenv step. 08:14:31 INFO - ##### 08:14:31 INFO - Running pre-action listener: _resource_record_pre_action 08:14:31 INFO - Running main action method: create_virtualenv 08:14:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:31 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 08:14:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:31 INFO - Using real prefix '/tools/python27' 08:14:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:35 INFO - Installing pip.................done. 08:14:35 INFO - Return code: 0 08:14:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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', '--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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:35 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 08:14:35 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 08:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:35 INFO - 'HOME': '/Users/cltbld', 08:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:35 INFO - 'LOGNAME': 'cltbld', 08:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:35 INFO - 'MOZ_NO_REMOTE': '1', 08:14:35 INFO - 'NO_EM_RESTART': '1', 08:14:35 INFO - 'PAGER': '/bin/cat', 08:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:35 INFO - 'PWD': '/builds/slave/test', 08:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:35 INFO - 'SHELL': '/bin/bash', 08:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:35 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:35 INFO - 'USER': 'cltbld', 08:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:35 INFO - 'XPC_FLAGS': '0x0', 08:14:35 INFO - 'XPC_SERVICE_NAME': '0', 08:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:36 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 08:14:36 INFO - Cleaning up... 08:14:36 INFO - Return code: 0 08:14:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:36 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 08:14:36 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 08:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:36 INFO - 'HOME': '/Users/cltbld', 08:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:36 INFO - 'LOGNAME': 'cltbld', 08:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:36 INFO - 'MOZ_NO_REMOTE': '1', 08:14:36 INFO - 'NO_EM_RESTART': '1', 08:14:36 INFO - 'PAGER': '/bin/cat', 08:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:36 INFO - 'PWD': '/builds/slave/test', 08:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:36 INFO - 'SHELL': '/bin/bash', 08:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:36 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:36 INFO - 'USER': 'cltbld', 08:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:36 INFO - 'XPC_FLAGS': '0x0', 08:14:36 INFO - 'XPC_SERVICE_NAME': '0', 08:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:36 INFO - Downloading/unpacking psutil>=0.7.1 08:14:36 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 08:14:36 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 08:14:36 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 08:14:36 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 08:14:36 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 08:14:36 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 08:14:38 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:14:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:39 INFO - Installing collected packages: psutil 08:14:39 INFO - Running setup.py install for psutil 08:14:39 INFO - building 'psutil._psutil_osx' extension 08:14:39 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 08:14:39 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 08:14:39 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 08:14:39 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 08:14:39 INFO - building 'psutil._psutil_posix' extension 08:14:39 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 08:14:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:14:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:14:39 INFO - ^ 08:14:39 INFO - 1 warning generated. 08:14:39 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 08:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:39 INFO - Successfully installed psutil 08:14:39 INFO - Cleaning up... 08:14:40 INFO - Return code: 0 08:14:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:40 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 08:14:40 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 08:14:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:40 INFO - 'HOME': '/Users/cltbld', 08:14:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:40 INFO - 'LOGNAME': 'cltbld', 08:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:40 INFO - 'MOZ_NO_REMOTE': '1', 08:14:40 INFO - 'NO_EM_RESTART': '1', 08:14:40 INFO - 'PAGER': '/bin/cat', 08:14:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:40 INFO - 'PWD': '/builds/slave/test', 08:14:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:40 INFO - 'SHELL': '/bin/bash', 08:14:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:40 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:40 INFO - 'USER': 'cltbld', 08:14:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:40 INFO - 'XPC_FLAGS': '0x0', 08:14:40 INFO - 'XPC_SERVICE_NAME': '0', 08:14:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:40 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 08:14:40 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 08:14:40 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 08:14:40 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 08:14:40 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 08:14:40 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 08:14:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:42 INFO - Installing collected packages: mozsystemmonitor 08:14:42 INFO - Running setup.py install for mozsystemmonitor 08:14:43 INFO - Successfully installed mozsystemmonitor 08:14:43 INFO - Cleaning up... 08:14:43 INFO - Return code: 0 08:14:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:43 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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:43 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 08:14:43 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 08:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:43 INFO - 'HOME': '/Users/cltbld', 08:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:43 INFO - 'LOGNAME': 'cltbld', 08:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:43 INFO - 'MOZ_NO_REMOTE': '1', 08:14:43 INFO - 'NO_EM_RESTART': '1', 08:14:43 INFO - 'PAGER': '/bin/cat', 08:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:43 INFO - 'PWD': '/builds/slave/test', 08:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:43 INFO - 'SHELL': '/bin/bash', 08:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:43 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:43 INFO - 'USER': 'cltbld', 08:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:43 INFO - 'XPC_FLAGS': '0x0', 08:14:43 INFO - 'XPC_SERVICE_NAME': '0', 08:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:43 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:47 INFO - Downloading docopt-0.6.1.tar.gz 08:14:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:47 INFO - Running setup.py install for blobuploader 08:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:47 INFO - Running setup.py install for requests 08:14:47 INFO - Running setup.py install for docopt 08:14:48 INFO - Successfully installed blobuploader requests docopt 08:14:48 INFO - Cleaning up... 08:14:48 INFO - Return code: 0 08:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:48 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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:48 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 08:14:48 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 08:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:48 INFO - 'HOME': '/Users/cltbld', 08:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:48 INFO - 'LOGNAME': 'cltbld', 08:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:48 INFO - 'MOZ_NO_REMOTE': '1', 08:14:48 INFO - 'NO_EM_RESTART': '1', 08:14:48 INFO - 'PAGER': '/bin/cat', 08:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:48 INFO - 'PWD': '/builds/slave/test', 08:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:48 INFO - 'SHELL': '/bin/bash', 08:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:48 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:48 INFO - 'USER': 'cltbld', 08:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:48 INFO - 'XPC_FLAGS': '0x0', 08:14:48 INFO - 'XPC_SERVICE_NAME': '0', 08:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:48 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-GXD_dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:48 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-0E5ZtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:48 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-ca0JVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:48 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-f2FD63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:48 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-7vHlUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-6H3M29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-cQWYMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-0MbWdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-dZ9z7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-LjwLeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Wr4shc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Vc4yhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:49 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-XkVNtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-6CDE1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-fdReqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-JDGwYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:50 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-PDE7v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:50 INFO - Running setup.py install for manifestparser 08:14:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Running setup.py install for mozcrash 08:14:50 INFO - Running setup.py install for mozdebug 08:14:50 INFO - Running setup.py install for mozdevice 08:14:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Running setup.py install for mozfile 08:14:51 INFO - Running setup.py install for mozhttpd 08:14:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Running setup.py install for mozinfo 08:14:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Running setup.py install for mozInstall 08:14:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:51 INFO - Running setup.py install for mozleak 08:14:52 INFO - Running setup.py install for mozlog 08:14:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Running setup.py install for moznetwork 08:14:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Running setup.py install for mozprocess 08:14:52 INFO - Running setup.py install for mozprofile 08:14:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Running setup.py install for mozrunner 08:14:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:52 INFO - Running setup.py install for mozscreenshot 08:14:53 INFO - Running setup.py install for moztest 08:14:53 INFO - Running setup.py install for mozversion 08:14:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:53 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 08:14:53 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 08:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:53 INFO - 'HOME': '/Users/cltbld', 08:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:53 INFO - 'LOGNAME': 'cltbld', 08:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:53 INFO - 'MOZ_NO_REMOTE': '1', 08:14:53 INFO - 'NO_EM_RESTART': '1', 08:14:53 INFO - 'PAGER': '/bin/cat', 08:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:53 INFO - 'PWD': '/builds/slave/test', 08:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:53 INFO - 'SHELL': '/bin/bash', 08:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:53 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:53 INFO - 'USER': 'cltbld', 08:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:53 INFO - 'XPC_FLAGS': '0x0', 08:14:53 INFO - 'XPC_SERVICE_NAME': '0', 08:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:53 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-y5nLcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:53 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)) 08:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:53 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-3I3Fxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-YB6zGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Tgg41I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-XItLkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-KCu9Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-36nsVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-kyCpny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-zQZSax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:54 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)) 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:54 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-bGJe56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-to_5bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-8b4lQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-QmWF2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-SrunIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-Xen_1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-42KXMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:55 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)) 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:55 INFO - Running setup.py (path:/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/pip-dIb0rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:56 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)) 08:14:56 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)) 08:14:56 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)) 08:14:56 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)) 08:14:56 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)) 08:14:56 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)) 08:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:56 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 08:14:56 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 08:14:56 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 08:14:56 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 08:14:56 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 08:14:56 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 08:14:58 INFO - Downloading blessings-1.5.1.tar.gz 08:14:58 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 08:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:58 INFO - Installing collected packages: blessings 08:14:58 INFO - Running setup.py install for blessings 08:14:58 INFO - Successfully installed blessings 08:14:58 INFO - Cleaning up... 08:14:58 INFO - Return code: 0 08:14:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:59 INFO - Reading from file tmpfile_stdout 08:14:59 INFO - Current package versions: 08:14:59 INFO - blessings == 1.5.1 08:14:59 INFO - blobuploader == 1.2.4 08:14:59 INFO - docopt == 0.6.1 08:14:59 INFO - manifestparser == 1.1 08:14:59 INFO - mozInstall == 1.12 08:14:59 INFO - mozcrash == 0.16 08:14:59 INFO - mozdebug == 0.1 08:14:59 INFO - mozdevice == 0.46 08:14:59 INFO - mozfile == 1.2 08:14:59 INFO - mozhttpd == 0.7 08:14:59 INFO - mozinfo == 0.8 08:14:59 INFO - mozleak == 0.1 08:14:59 INFO - mozlog == 3.0 08:14:59 INFO - moznetwork == 0.27 08:14:59 INFO - mozprocess == 0.22 08:14:59 INFO - mozprofile == 0.27 08:14:59 INFO - mozrunner == 6.11 08:14:59 INFO - mozscreenshot == 0.1 08:14:59 INFO - mozsystemmonitor == 0.0 08:14:59 INFO - moztest == 0.7 08:14:59 INFO - mozversion == 1.4 08:14:59 INFO - psutil == 3.1.1 08:14:59 INFO - requests == 1.2.3 08:14:59 INFO - wsgiref == 0.1.2 08:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:59 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')]} 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:59 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')]} 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:59 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 0x1013bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10142b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafeae4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, '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.EasTp0nVtK/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.fFraSSP2yx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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 08:14:59 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 08:14:59 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 08:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:59 INFO - 'HOME': '/Users/cltbld', 08:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:59 INFO - 'LOGNAME': 'cltbld', 08:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:59 INFO - 'MOZ_NO_REMOTE': '1', 08:14:59 INFO - 'NO_EM_RESTART': '1', 08:14:59 INFO - 'PAGER': '/bin/cat', 08:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:59 INFO - 'PWD': '/builds/slave/test', 08:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:59 INFO - 'SHELL': '/bin/bash', 08:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:14:59 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:59 INFO - 'USER': 'cltbld', 08:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:59 INFO - 'XPC_FLAGS': '0x0', 08:14:59 INFO - 'XPC_SERVICE_NAME': '0', 08:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 INFO - Cleaning up... 08:14:59 INFO - Return code: 0 08:14:59 INFO - Running post-action listener: _resource_record_post_action 08:14:59 INFO - Running post-action listener: _start_resource_monitoring 08:14:59 INFO - Starting resource monitoring. 08:14:59 INFO - ##### 08:14:59 INFO - ##### Running install step. 08:14:59 INFO - ##### 08:14:59 INFO - Running pre-action listener: _resource_record_pre_action 08:14:59 INFO - Running main action method: install 08:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:59 INFO - Reading from file tmpfile_stdout 08:14:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:59 INFO - Reading from file tmpfile_stdout 08:14:59 INFO - Output received: 08:14:59 INFO - Usage: mozinstall [options] installer 08:14:59 INFO - Options: 08:14:59 INFO - -h, --help show this help message and exit 08:14:59 INFO - -d DEST, --destination=DEST 08:14:59 INFO - Directory to install application into. [default: 08:14:59 INFO - "/builds/slave/test"] 08:14:59 INFO - --app=APP Application being installed. [default: firefox] 08:14:59 INFO - mkdir: /builds/slave/test/build/application 08:14:59 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'] 08:14:59 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 08:15:38 INFO - Reading from file tmpfile_stdout 08:15:38 INFO - Output received: 08:15:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:15:38 INFO - Running post-action listener: _resource_record_post_action 08:15:38 INFO - ##### 08:15:38 INFO - ##### Running run-tests step. 08:15:38 INFO - ##### 08:15:38 INFO - Running pre-action listener: _resource_record_pre_action 08:15:38 INFO - Running main action method: run_tests 08:15:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:38 INFO - 2015-11-09 08:15:38.605 screenresolution[1935:12754] starting screenresolution argv=screenresolution get 08:15:38 INFO - 2015-11-09 08:15:38.609 screenresolution[1935:12754] Display 0: 1600x1200x32@60 08:15:38 INFO - 2015-11-09 08:15:38.615 screenresolution[1936:12756] starting screenresolution argv=screenresolution list 08:15:38 INFO - Available Modes on Display 0 08:15:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:38 INFO - Intel HD Graphics 3000: 08:15:38 INFO - Chipset Model: Intel HD Graphics 3000 08:15:38 INFO - Type: GPU 08:15:38 INFO - Bus: Built-In 08:15:38 INFO - VRAM (Total): 512 MB 08:15:38 INFO - VRAM (Dynamic, Max): 10 08:15:38 INFO - Vendor: Intel (0x8086) 08:15:38 INFO - Device ID: 0x0116 08:15:38 INFO - Revision ID: 0x0009 08:15:38 INFO - Displays: 08:15:38 INFO - Display: 08:15:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:38 INFO - Display Serial Number: 1600x1200 60 08:15:38 INFO - Main Display: Yes 08:15:38 INFO - Mirror: Off 08:15:38 INFO - Online: Yes 08:15:38 INFO - Rotation: Supported 08:15:38 INFO - Return code: 0 08:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:38 INFO - Python 2.7.3 08:15:38 INFO - Return code: 0 08:15:38 INFO - grabbing minidump binary from tooltool 08:15:38 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')]} 08:15:38 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 0x1013739f0>, '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 0x1010d2cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10133d990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:38 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 08:15:38 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 08:15:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:38 INFO - Return code: 0 08:15:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:15:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:15:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:38 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/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0080', '--webServer', 'localhost'] in /builds/slave/test/build 08:15:38 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/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0080 --webServer localhost 08:15:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EasTp0nVtK/Render', 08:15:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:38 INFO - 'HOME': '/Users/cltbld', 08:15:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:38 INFO - 'LOGNAME': 'cltbld', 08:15:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:38 INFO - 'MOZ_NO_REMOTE': '1', 08:15:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:38 INFO - 'NO_EM_RESTART': '1', 08:15:38 INFO - 'PAGER': '/bin/cat', 08:15:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:38 INFO - 'PWD': '/builds/slave/test', 08:15:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:38 INFO - 'SHELL': '/bin/bash', 08:15:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fFraSSP2yx/Listeners', 08:15:38 INFO - 'TMPDIR': '/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/', 08:15:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:38 INFO - 'USER': 'cltbld', 08:15:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:38 INFO - 'XPC_FLAGS': '0x0', 08:15:38 INFO - 'XPC_SERVICE_NAME': '0', 08:15:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:15:38 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/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0080', '--webServer', 'localhost'] with output_timeout 3600 08:15:39 INFO - mozversion INFO | application_buildid: 20151109055233 08:15:39 INFO - mozversion INFO | application_changeset: cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 08:15:39 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:15:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:39 INFO - mozversion INFO | application_name: Firefox 08:15:39 INFO - mozversion INFO | application_remotingname: firefox-dev 08:15:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:39 INFO - mozversion INFO | application_vendor: Mozilla 08:15:39 INFO - mozversion INFO | application_version: 44.0a2 08:15:39 INFO - mozversion INFO | platform_buildid: 20151109055233 08:15:39 INFO - mozversion INFO | platform_changeset: cafe4b776cac0e837a746ee638c2cbbe4b89dcc7 08:15:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:39 INFO - mozversion INFO | platform_version: 44.0a2 08:15:39 INFO - 2015-11-09 08:15:39,239 DEBUG : using testdate: 1447085739 08:15:39 INFO - 2015-11-09 08:15:39,239 DEBUG : actual date: 1447085739 08:15:39 INFO - 2015-11-09 08:15:39,355 INFO : starting webserver on 'localhost:49795' 08:15:39 INFO - 2015-11-09 08:15:39,356 INFO : Starting test suite t-yosemite-r5-0080 08:15:39 INFO - 2015-11-09 08:15:39,356 INFO : Starting test dromaeo_css 08:15:39 INFO - 2015-11-09 08:15:39,356 DEBUG : operating with platform_type : mac_ 08:15:39 INFO - 2015-11-09 08:15:39,357 INFO : Initialising browser for dromaeo_css test... 08:15:39 INFO - 2015-11-09 08:15:39,387 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpvMHUII/profile http://localhost:49795/getInfo.html 08:15:41 INFO - 2015-11-09 08:15:41,855 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:15:41 INFO - 2015-11-09 08:15:41,855 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:15:41 INFO - 2015-11-09 08:15:41,855 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:15:41 INFO - 2015-11-09 08:15:41,855 DEBUG : BROWSER_OUTPUT: __metrics 08:15:41 INFO - 2015-11-09 08:15:41,871 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:42 INFO - 2015-11-09 08:15:42,650 INFO : Browser initialized. 08:15:42 INFO - 2015-11-09 08:15:42,650 INFO : Running cycle 1/1 for dromaeo_css test... 08:15:42 INFO - 2015-11-09 08:15:42,650 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpvMHUII/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:15:54 INFO - 2015-11-09 08:15:54,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 200003584 08:15:54 INFO - 2015-11-09 08:15:54,649 DEBUG : BROWSER_OUTPUT: 08:16:46 INFO - 2015-11-09 08:16:46,425 DEBUG : BROWSER_OUTPUT: 1447085806419 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] 08:18:56 INFO - 2015-11-09 08:18:56,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49795/tests/dromaeo/cssquery-ext.html) 08:18:57 INFO - 2015-11-09 08:18:57,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 299970560 08:18:57 INFO - 2015-11-09 08:18:57,933 DEBUG : BROWSER_OUTPUT: 08:22:00 INFO - 2015-11-09 08:22:00,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-ext.html (next: http://localhost:49795/tests/dromaeo/cssquery-jquery.html) 08:22:01 INFO - 2015-11-09 08:22:01,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 343265280 08:22:01 INFO - 2015-11-09 08:22:01,080 DEBUG : BROWSER_OUTPUT: 08:25:03 INFO - 2015-11-09 08:25:03,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49795/tests/dromaeo/cssquery-mootools.html) 08:25:03 INFO - 2015-11-09 08:25:03,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 301146112 08:25:03 INFO - 2015-11-09 08:25:03,782 DEBUG : BROWSER_OUTPUT: 08:28:05 INFO - 2015-11-09 08:28:05,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49795/tests/dromaeo/cssquery-prototype.html) 08:28:06 INFO - 2015-11-09 08:28:06,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 295399424 08:28:06 INFO - 2015-11-09 08:28:06,400 DEBUG : BROWSER_OUTPUT: 08:31:09 INFO - 2015-11-09 08:31:09,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49795/tests/dromaeo/cssquery-yui.html) 08:31:10 INFO - 2015-11-09 08:31:10,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 302305280 08:31:10 INFO - 2015-11-09 08:31:10,187 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/dromaeo/cssquery-yui.html (next: http://localhost:49795/tests/dromaeo/cssquery-dojo.html) 08:34:12 INFO - 2015-11-09 08:34:12,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 345464832 08:34:12 INFO - 2015-11-09 08:34:12,879 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:34:12 INFO - 2015-11-09 08:34:12,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:34:12 INFO - 2015-11-09 08:34:12,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:34:12 INFO - 2015-11-09 08:34:12,881 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:34:12 INFO - 2015-11-09 08:34:12,882 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2957.171991842285;2989.4768415527305;2997.4304882072406;3017.8491075446236;3155.589773329467;5031.320771695825;5064;5068.391792984838;5094.108531007073;5101.464346243637;4898.730569818658;5044.319016932713;5115.079285728568;5167.173252279636;5255.684658920468;4387.890302742425;4498.302763071729;4656.231721765913;4689.991651794863;4753.144434001878;4573.519780423041;4633.374494443257;4699.130660827758;4778.880527986811;4789.568938795508;4754.6196304295745;4766.094442056015;4782.736949467778;4784.473707892129;4805.567498925096;4352;4725.740084295362;4734.857954261343;4747.643926705494;4804.1352556539805;4553.977230113828;4599.816007359702;4624.028953919647;4639.095376401603;4654.441467023945;4924.778384972685;4951.678140920829;4990.65065445419;5001.724905130216;5087.313212716273;5216.035033518811;5315.681059136426;5327.094393953037;5341.43914888935;5342.439043900374;5403.243545903538;5460.208269800896;5473.233747275384;5513.972430137864;5520.613557051008;5143.948560514422;5192.92210616841;5192.974035129876;5219.060569097523;5232.39827419844;5240.580753539708;5623.381428042912;5673.858153546194;5691.686957217393;5710.600257981901;5053.469385714447;5087.720175390389;5183.170692689227;5268.420473747885;5290.497402746733;5464.754086066137;5467.972660136754;5471.37079235885;5475.917861232085;5477.643953143112;5031.496850314939;5335.093034184198;5346.304980352529;5363.356397232357;5409.161579955114;5110.310108135429;5170.353705786777;5205.791768329224;5234.502722241381;5245.0558899398475;4121.835126594902;4138.91722165555;4141.088960428701;4155.58444155582;4161.979190104091;3627.8004709741217;3786.1481166737813;3793.3551296279697;3797;3808.27642747877;4895.31465594817;4977.950220497821;4999.350084489066;5014.122528557488;5020.2720605511995;5554.666719996732;5555.555555555546;5563.638363506359;5597.552195824324;5608.803691870847;4789.568938795525;5116.692998420107;5132.743362831919;5142.202958541432;5163.845084647466;4662;4734.147853386424;4734.431868175841;4758.357621721093;4774.164521208774;5578.97210513953;5611.551075913835;5617.9719101404235;5623.072193088258;5631.070873305859;5216;5574.136008918624;5575.386707462257;5581.49766521015;5586.413426590312;5506.752196151103;5520.889582208253;5544.473275038865;5605.383407825218;5637.098064309691;5449.155380915964;5474.124140137559;5480.424555421623;5503.394626590992;5526.972365138148;5289.20661900718;5523.861903452285;5536.806211782729;5560.749766260447;5570.805021824217;5064.949350506447;5077.7715002824225;5106.642535022513;5132.948670513247;5134.409542902465;5264.9210261846865;5398.892022159614;5405.216243644571;5414.431484694208;5461.590380721383;5103.591712662904;5273.129933560919;5300.761465734128;5314.840554783363;5336.813211537577;5236.921446178234;5283.920741188808;5304.787808487617;5329.520343169133;5371.62398632092;5193.532582067632;5201.193814958688;5218.582513398995;5220.660657057279;5247.658902171346 08:34:12 INFO - 2015-11-09 08:34:12,884 DEBUG : BROWSER_OUTPUT: |1;ext.html;522.034236662175;524.4074196158341;525.2384043137451;525.4141632080232;548.2954403591386;30587.847060764692;31579.052628421156;36889.63110368895;37315.253694926156;37331.813340933324;39340;39847.40228896569;39971.00072498189;40033.79983100088;40045.19909601806;7829.647665855022;8412.831743365145;8600.311975042014;8614.698485553006;8621.61202745878;7995.920040799605;10208;10454.372737635727;10475.161987041018;10487.318324308933;10119.848202276971;10284.485775711222;10303.27877048607;10323.53544090514;10358.637447689332;8031.317338026275;8186.795330116735;10096.747581310452;10231.897681023207;10345.844812327821;10016.09855113036;10145.695629131138;10152.492375381202;10160.33957792741;10225.437600931946;37853.432198517046;38281.234375312335;38332.425013624816;38375.61624383748;38426.42360364597;2733.7129601391766;2845.2460098074025;3038.3923215357017;3206.1183174627163;3225.0647312279643;26001;26193.214203573923;26303;26536.203913882615;26712.46575068507;2104.3371338028473;2141.486043349585;2167.783221677835;2174.3150907464255;2182.7598964114095;244766;249023;249330;249926;250662;51545.48454515482;52648;60003.499737518985;60296.39703602996;60401;69347.65326173337;70030;70211;70621;70648.2935170652;16337.18314084291;16347.918260408622;16571.25429355682;16595.91702041482;16617.750733739005;12521.436535355931;12538.623841284776;12589.622311330491;12617.49530018789;12617.810732839014;19168.632603696948;19429.72470496999;19430.304235434425;19531.316403925794;19593.412197634094;7838.372930165573;7973.521588704581;8005.399595030396;8015.438919275594;8020.79948001293;837.7403005068448;870.6691457246333;939.7791518993031;953.7949340891741;960.582146766159;24702.13542526003;25228;25667;26090;26370.73629263683;895.7581453007782;976.3556053004983;1001.7878367175799;1083.106437189322;1133.019937753837;10512.579496820195;13487.05590608648;13567.59297221085;13735.587932362045;13812.171269723849;305534;308341;309010;310628;312064;46391.30413043807;47469.28796068062;51878;53258.46741532535;53425;1263.873612638747;1265.7658333208385;1296.461968283152;1298.9932802078276;1299.493197652916;24903.377415564755;25224.747752522973;26125.73874261309;26140.86929565416;26261;41978.580214197464;42349;42390.36414453724;42441.36337954995;42733.14533709371;252567;254400;255341;255413;255871;28518;28994.27514312159;29325.560116598695;29353.706462935097;29356.706432935396;40174.79912600418;40278.38190517607;41150.38274425826;41565.584344156174;41650.166996660504;31862.522062169548;34020;34174.31651366909;34557.30885382228;34840.65159348374;33833.66166338305;34240.657593424745;34293;34729.82635086808;35951.820240898625;32817.34365312633;33519.329613407106;33798;33805.492917606745;33856.322873542886;28338.43323133567;29210.269743256587;29733.405331893675;29902.850485747433;30008;21649.35051948444;22491;22821.771782282627;22905.65641515412;23078.60240342131 08:34:12 INFO - 2015-11-09 08:34:12,886 DEBUG : BROWSER_OUTPUT: |2;jquery.html;305.8272076276905;313.9105354973833;319.68511016648597;321.7313543191435;329.2066120649235;13473.528426505074;13900.582982510516;16596.25316860741;16830.49508514745;17202.225899834506;13999;14113.64715882101;15608.921955390235;16539.338426462928;16580.50258492244;4890.731009794469;5010.3737032870895;5013.949860501403;5025.447200807908;5051.06555287273;3673.9081522961874;4950.480199579047;5012.624053196007;5014.799408023675;5022.397312322526;4970.676906001117;5179.948200517984;5350.705711185883;5354;5368.0605893968595;4313.09425020746;4430.847979525314;5287.894242115155;5307.787688492455;5332.120200166968;3747;3762.849486020556;3763.0404246917133;3768.3028639701743;3782.867599634;12446.626601201979;12448.875511244862;12671.17637353569;12703.936480317632;12715.55495557651;1621.2218135295125;1704.1649591700102;1720.096949101719;1764.1796564597523;1842.3183422133761;8879.822403551958;8981.640734370618;9036.548172591343;9270.721878343593;9333.06669333068;1363.3183408295852;1398.2100113435877;1403.3474434387956;1424.7293014327245;1437.9712405751932;54006.45993540053;54693.453065469235;55579.44420555783;55657.99999999959;56388.43611563914;6051.727672254759;6102.145699602059;6116.449519543263;6139.662318572521;6145.078238264206;7028.437724981989;7032.718691252395;7036.683349249296;7047.541909775849;7081.37128460457;5206.140986737221;5207.895842083137;5222.3472065991755;5227.738613069331;5249.107651699221;5607.579431542651;5625.240592520039;5661.179129026351;5663.433656634304;5672.829815105553;2727.8772455239564;2742.0951086141527;2766.4467106578763;2768.792340574465;2777.180731684158;972.8666103988916;996.038822536256;1027.8509616105623;2770.667519897585;2849.7292757188034;382.4664592892899;387.5504414878727;430.8039841871941;433.02137169996035;450.682269000354;10660.987191253316;11234.606788762354;11444.084473242287;11451.59919402817;11521.366324852213;403.9939400908989;432.8182163491341;435.3991491741377;436.3585529271965;444.63539897283914;5804.767809287666;5864.70676466175;5927.673977931255;5969.611975221596;5991.310999235144;511586;511608;514367;514417;531939;65238;66746.33253667498;70181.64909175523;73843.26156738472;75516.24483755202;458.46130796314196;464.02786162988485;465.9743714095757;466.55677106748726;467.05421521419396;9835.704928852147;10199.184065274612;10216.693499195037;10252.897471025493;10386.896131038593;33452.498212527316;33599.664003359656;33618.49572256369;34358.82820585881;34471.4829277566;44103;45369.773151135356;45842;47490.76254618705;47809.04381912412;5711.571632127524;5920.555958303058;5954.166416701752;5957.106434034929;5962.642241465526;9304.813903721752;11073;11228.922649309903;11373.14701397382;11403.885961140282;9471.857922131312;9484.95257523708;9516.857247141437;9843.950780246052;9848.261380396641;9246.214071803972;9473.952630236805;9499;9514.619415223591;9625;8360.45657032291;9495.762605934908;9499.145076943109;9768.26737994639;9830.75423114428;5453.2365468833605;5526.585506086979;5814.825555233349;5865.794697185578;5908.586398952204;9702.417854928726;9798.559064842242;9808.558614862206;9870.654527091518;9906.455144967096 08:34:12 INFO - 2015-11-09 08:34:12,887 DEBUG : BROWSER_OUTPUT: |3;mootools.html;800.7998000499875;1535.6391248056705;1614.0557773702392;1636.23914879581;1647.8269781672925;6043.123747056674;6321.968390158048;6429.614223146608;6430.678466076701;6442.935570644304;6455.451286640629;6511.28375878653;6567.802965911018;6583.473322134229;6586.4401525870235;1712.1182590965664;1746.97379539307;1892.7444794952712;1915.2913422033866;1927.2194761121698;1951.7657881054222;1962.0484065228352;1963.4894927318858;1967.2622766462578;1968.2323893681476;1889.5842914558775;1900.5153685810099;1960.5196726801953;1960.5784756277399;1963.3717210492648;1881.6707076261737;1922.951926201842;1938.5153711572107;1941.2720229913782;1943.24213556713;1970.5861769028377;1984.811442912921;1992.3325685895243;2000.9699854502048;2001.539645881441;6574.309697481791;6622.569532980341;6647;6648.867022659568;6658.201015878077;4001.9599804001878;4072.5112986441522;4073.185362927397;4081.3673880548563;4089.652379547742;2235.7205349331334;2284.931452056441;2330.953380932372;2334.8248881333966;2375.0381095656285;684.3498676257525;688.6384648059759;700.8247938015496;737.2885165814961;751.8345963887936;8395.118512556215;8400.41197116202;8416.326693864537;8423.452475589067;8451.661933522651;3629.491871138043;3650.6896913762625;3681.723870709654;3768.6042965488778;3773;7589.734359297398;7596.316331530189;7610;7611.086669599684;7625.542467451971;4159.584041595876;4167.333226683716;4171.812268447927;4176.791160441966;4177.060161463707;3818.1981783825154;3820.9617903820604;3826.196498735241;3834.194819087967;3839.078621130964;3168.287135394564;3191.393635209303;3218.3241519280746;3240.740740740735;3252.10567094051;998.960041598328;1023.7133602591138;1027.342500799489;1032.3702541449709;1035.0994634667736;1193.40926241511;1205.813098969661;1209.7459533497888;1227.533537255837;1244.8630650628425;6281.96859015702;6318.462930650946;6366.045093235959;6377.649229292433;6385.680715964183;432.37305906435796;440.63867628544284;440.8324836562086;443.4855567541636;448.614191795056;5091.66904151229;5098.847034588968;5125.333706618116;5130.050940576006;5134.409542902614;7507.699692012258;7574.356179724675;7623.047119110111;7664.961675191588;7681.3854891608535;7630.008098947213;7641.69433222676;7643.235676432423;7649.655765490566;7655.234476552411;6177.505799536116;6197.380261973766;6199.3490683478485;6213.2233470816145;6240.843978900473;5829.271341082364;6004.849878753066;6016.278046634432;6030.7286172121485;6039.4262545058145;6865.450763938973;6948.687309071003;7012.894806578008;7023.33278338557;7057.400120989568;6978.267281935324;7108.218096009538;7117.43060555144;7125.394341481032;7139.785806425815;5693.345265294544;5761.740721667619;5761.827145185651;5766.567507437043;5799.159121927381;6321.494280457644;6408.647524386203;6409.583377080475;6410.262819775786;6418.839529011625;5621.80323688669;5678.119891416837;5757.625754325955;5812.244408226903;5816.272965879265;5824.563157763269;5831.037878750129;5880.970595147168;5900.64596124234;5953.493953014043;5738.311402631711;5783.797567085132;5792.333881603669;5799.130130480462;5858.209141765807;5308.230306605444;5310.575153987749;5326.760295786621;5335.06636338647;5354.3574771027725;5145.691258524501;5544.1960915667805;5570.749316280858;5612.803551875665;5620.213170156099 08:34:12 INFO - 2015-11-09 08:34:12,891 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.8794930230698;290.55835130601486;295.4386665335862;306.771455265827;309.53260576529436;5499.50504454599;5588.497035266825;5672.149177623359;5682.971585142079;5694.515966142878;5474.178873169027;5478.342598888129;5535.335759708831;5548.0845660466075;5598.832035038945;4182.414461975318;4205.03284244624;4207.410962465257;4219.324908014718;4236.04688944988;4150.418941348214;4203.47456567929;4215.810288537024;4221.134667393192;4229.598188172119;4229.34445160999;4250.404943307939;4270.935935960963;4272.679549033819;4301.784910754465;4247.044415006599;4263.936040959388;4282.850100246492;4285.46431696038;4286.785660716982;3701.5188025556504;3701.8519259229597;3722.4788529605876;3725.925481490382;3726.4782930389765;5263.054303540816;5347.866303342447;5425.348958125051;5430.402655707869;5453.781848726086;4883.902321953577;4886.877828054292;4897.681650692693;4910.361652985089;4919.237518184651;5880.558958078162;5887.705614719247;5890.823275301748;5894.557908156906;5906.320773111104;4032.052467670095;4042.9595704042877;4045.8786236412957;4052.716309858311;4081.08175660477;5950.196723442366;6071.210742603434;6110.816675499742;6128.632282063046;6135.049067394561;3960.960390396117;4003.579624139482;4007.3788562772233;4010.478637777129;4017.1563971566297;4051.9797401012806;4077.7961101944784;4113.095119073799;4113.382992551082;4125.525564560054;4701.341812146302;4729.0541891621815;4739.052189562101;4740.478547359788;4757.405324334458;5727.284089488814;5812.273465816773;5878.147668588116;5885.382034886361;5908.645481271052;1458.2854401343266;1481.799957005812;1484.4730120807174;1485.049568276304;1485.1460410264142;903.9909600903907;914.4421902639384;917.3440989692402;921.5346250143634;950.3157726436955;5579.218909352694;5623.831285061455;5629.408912064257;5641.915371269434;5651.011073062197;6007.549433792483;6128.908066379008;6131.264248290234;6142.938570614326;6147.877042459126;5533.889322213533;5568.610197286151;5603.411641777636;5614.803481878196;5616.073347897551;3312.966870331266;3356.848941797625;3370.764046516769;3375.561177046968;3380.9857042887033;6105.45050945417;6125.203723515914;6144.354842741537;6155.138280640714;6157.291911430153;6059;6243;6243.219597550306;6250.6874656267;6327.525435592349;6202.131701561785;6205.503559715122;6215.440610345091;6243.219597550306;6258.561900666909;6124.081387791867;6142.815715528542;6152.984757515139;6167.6916154193;6177.1969643945995;5884.676342801187;6038.094285857156;6046.969765151146;6050.6369617823075;6054.727537260922;6212.316645169119;6218.129461875251;6229.345918678474;6232.376762323732;6251.187345645037;3804.5624753152633;3822.6941844652915;3832.1952389997296;3834.5973672763957;3858.9035274118373;5970.0746384310505;6110.2973158085615;6144.877102457836;6158.753649853956;6166.075088736726;5973.940260597338;5977.193078934288;5991.7603295867675;5997.670128142994;6006.249218847644;5957.672328021827;5958.76164953397;5962.25471816023;5966.701664916824;6017.157597936205;5655.773769049192;5836.620619659709;5856.619319744203;5875.265591801025;5878.177055212188;5944.405559444194;5982.192404025401;6000.249968753906;6001.099835024781;6001.669908155093;5806.506446952057;5876.1773351731645;5888.528917686661;5898.351181370132;5911.733971971357 08:34:12 INFO - 2015-11-09 08:34:12,892 DEBUG : BROWSER_OUTPUT: |5;yui.html;589.7257775134565;627.1627377451102;647.258888572584;715.7029832619463;731.4112139727517;12607.495700171994;13169.209847409138;13169.802452963213;13185.011124165678;13285.070045096847;11441.885581144186;12165;12301.630951071482;12343.876561234385;12349;845.0619812008681;862.0302160069921;864.1660797330575;866.9393142480029;868.5179725252482;850.0564373545391;862.5126803356115;863.9891327147253;864.0279685353977;865.7186414415308;884.9778505825782;889.7775556110972;890.9931777091878;891.6700820696351;891.9866202006975;882.8322618702426;885.1590988560893;885.2740752582885;885.3094586222757;885.6988623867851;655.596807963104;655.6951017776756;655.8884989551788;656.0880376276979;656.2879275985562;12657.683557911034;12702.682432939158;12849.614511564669;12938.676533086655;12952.611421657366;10371.585136594527;10761.730956726065;10803.729906752316;11044.392558409285;11638.41807909601;8274.544900030496;8447.662093516252;8473.576321183917;8489.066202717697;8501.914980850173;3009.5184770436626;3097.349556593118;3097.7366923811505;3101.8449077546256;3107.564940908275;40246.79876600627;40904.59095409067;43117.11945924882;43335.78332108351;45189.77405112986;7875.409344299201;7997.280244777881;8050.919490805134;8086.15095414973;8393.076761556224;16988.49034528966;17002.48992530226;17024.744628830576;17053.317867285168;17076.316947322215;6090.451859332681;6189.071639254058;6505.70985129097;6669.466442684574;6697.866042679217;3581;3679.2089700714473;3705.2404257127223;3707.6848467879995;3719.9956011876643;2721.3468767496056;2757.6139340492346;2762.1713485954533;2768.335599456116;2774.680911695181;397.23333965446966;397.9204159168178;405.5842761169766;408.88142438692444;411.4198979438977;377.45269359428937;441.99558004420186;477.7372445155151;496.44894167474075;517.6350672775684;6323.652199129;6473.611583305017;6527.771527996498;6552.115464412243;6567.080608714784;472.4684729679111;500.31207090250905;511.12342332898515;511.58050398673475;523.3301374240901;2930.457865294927;3113.9377212455624;3222.307203951115;3318.0377690469495;3410.4031794435873;55592.72203638956;57328.14007789887;57353.42646573481;58118;58339;50144.49855501471;50705;50710.74644626827;50782;50978.23532647013;37807.43288850669;42959.78520107379;43133.568664313585;43478;43604.781976089915;6794.456443484411;6858.074159988338;6932;7051.048108505286;7196.568205907663;34099.829500852335;34120.317593648484;34344.14139646529;34522.30955380928;34720.131996700286;40694;42115.368269475366;43816.78091609649;44323;44635.77682111569;6744.325567443217;6770.5599136056;6777.966110169417;6845.315468453115;6937.7571784987285;9936.75158121024;10026.097651211427;10098.192144628265;10149.137323327599;10215.284930055122;9176.6788162414;9358;9472.100150485692;9708.708738737849;9877.111060004634;9632.614695412105;9686.612535498783;9712.951435242778;9795.951020244853;10319.226058045526;8661.956690216508;8719.476831390137;8960.1935825776;9025;9317.487538185194;8368.748937531884;8515.233628973423;8553.101924297858;8663.653453861774;8797.736067917973;7761.61191940412;8259.83480330378;8325.666973321;8414.789630259047;8472.449290796325 08:34:12 INFO - 2015-11-09 08:34:12,892 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:34:12 INFO - 2015-11-09 08:34:12,892 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:34:12 INFO - 2015-11-09 08:34:12,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1026 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: __startTimestamp1447086852879__endTimestamp 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,893 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5044.14 Median:5192.92 stddev:557.60 (10.7%) stddev-sans-first:534.74 08:34:12 INFO - 2015-11-09 08:34:12,895 DEBUG : BROWSER_OUTPUT: Values: 2957.2 2989.5 2997.4 3017.8 3155.6 5031.3 5064.0 5068.4 5094.1 5101.5 4898.7 5044.3 5115.1 5167.2 5255.7 4387.9 4498.3 4656.2 4690.0 4753.1 4573.5 4633.4 4699.1 4778.9 4789.6 4754.6 4766.1 4782.7 4784.5 4805.6 4352.0 4725.7 4734.9 4747.6 4804.1 4554.0 4599.8 4624.0 4639.1 4654.4 4924.8 4951.7 4990.7 5001.7 5087.3 5216.0 5315.7 5327.1 5341.4 5342.4 5403.2 5460.2 5473.2 5514.0 5520.6 5143.9 5192.9 5193.0 5219.1 5232.4 5240.6 5623.4 5673.9 5691.7 5710.6 5053.5 5087.7 5183.2 5268.4 5290.5 5464.8 5468.0 5471.4 5475.9 5477.6 5031.5 5335.1 5346.3 5363.4 5409.2 5110.3 5170.4 5205.8 5234.5 5245.1 4121.8 4138.9 4141.1 4155.6 4162.0 3627.8 3786.1 3793.4 3797.0 3808.3 4895.3 4978.0 4999.4 5014.1 5020.3 5554.7 5555.6 5563.6 5597.6 5608.8 4789.6 5116.7 5132.7 5142.2 5163.8 4662.0 4734.1 4734.4 4758.4 4774.2 5579.0 5611.6 5618.0 5623.1 5631.1 5216.0 5574.1 5575.4 5581.5 5586.4 5506.8 5520.9 5544.5 5605.4 5637.1 5449.2 5474.1 5480.4 5503.4 5527.0 5289.2 5523.9 5536.8 5560.7 5570.8 5064.9 5077.8 5106.6 5132.9 5134.4 5264.9 5398.9 5405.2 5414.4 5461.6 5103.6 5273.1 5300.8 5314.8 5336.8 5236.9 5283.9 5304.8 5329.5 5371.6 5193.5 5201.2 5218.6 5220.7 5247.7 08:34:12 INFO - 2015-11-09 08:34:12,895 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,895 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43717.34 Median:29955.43 stddev:71151.69 (237.5%) stddev-sans-first:71277.37 08:34:12 INFO - 2015-11-09 08:34:12,896 DEBUG : BROWSER_OUTPUT: Values: 522.0 524.4 525.2 525.4 548.3 30587.8 31579.1 36889.6 37315.3 37331.8 39340.0 39847.4 39971.0 40033.8 40045.2 7829.6 8412.8 8600.3 8614.7 8621.6 7995.9 10208.0 10454.4 10475.2 10487.3 10119.8 10284.5 10303.3 10323.5 10358.6 8031.3 8186.8 10096.7 10231.9 10345.8 10016.1 10145.7 10152.5 10160.3 10225.4 37853.4 38281.2 38332.4 38375.6 38426.4 2733.7 2845.2 3038.4 3206.1 3225.1 26001.0 26193.2 26303.0 26536.2 26712.5 2104.3 2141.5 2167.8 2174.3 2182.8 244766.0 249023.0 249330.0 249926.0 250662.0 51545.5 52648.0 60003.5 60296.4 60401.0 69347.7 70030.0 70211.0 70621.0 70648.3 16337.2 16347.9 16571.3 16595.9 16617.8 12521.4 12538.6 12589.6 12617.5 12617.8 19168.6 19429.7 19430.3 19531.3 19593.4 7838.4 7973.5 8005.4 8015.4 8020.8 837.7 870.7 939.8 953.8 960.6 24702.1 25228.0 25667.0 26090.0 26370.7 895.8 976.4 1001.8 1083.1 1133.0 10512.6 13487.1 13567.6 13735.6 13812.2 305534.0 308341.0 309010.0 310628.0 312064.0 46391.3 47469.3 51878.0 53258.5 53425.0 1263.9 1265.8 1296.5 1299.0 1299.5 24903.4 25224.7 26125.7 26140.9 26261.0 41978.6 42349.0 42390.4 42441.4 42733.1 252567.0 254400.0 255341.0 255413.0 255871.0 28518.0 28994.3 29325.6 29353.7 29356.7 40174.8 40278.4 41150.4 41565.6 41650.2 31862.5 34020.0 34174.3 34557.3 34840.7 33833.7 34240.7 34293.0 34729.8 35951.8 32817.3 33519.3 33798.0 33805.5 33856.3 28338.4 29210.3 29733.4 29902.9 30008.0 21649.4 22491.0 22821.8 22905.7 23078.6 08:34:12 INFO - 2015-11-09 08:34:12,896 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,896 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25559.68 Median:5018.60 stddev:84681.24 (1687.3%) stddev-sans-first:84897.56 08:34:12 INFO - 2015-11-09 08:34:12,897 DEBUG : BROWSER_OUTPUT: Values: 305.8 313.9 319.7 321.7 329.2 13473.5 13900.6 16596.3 16830.5 17202.2 13999.0 14113.6 15608.9 16539.3 16580.5 4890.7 5010.4 5013.9 5025.4 5051.1 3673.9 4950.5 5012.6 5014.8 5022.4 4970.7 5179.9 5350.7 5354.0 5368.1 4313.1 4430.8 5287.9 5307.8 5332.1 3747.0 3762.8 3763.0 3768.3 3782.9 12446.6 12448.9 12671.2 12703.9 12715.6 1621.2 1704.2 1720.1 1764.2 1842.3 8879.8 8981.6 9036.5 9270.7 9333.1 1363.3 1398.2 1403.3 1424.7 1438.0 54006.5 54693.5 55579.4 55658.0 56388.4 6051.7 6102.1 6116.4 6139.7 6145.1 7028.4 7032.7 7036.7 7047.5 7081.4 5206.1 5207.9 5222.3 5227.7 5249.1 5607.6 5625.2 5661.2 5663.4 5672.8 2727.9 2742.1 2766.4 2768.8 2777.2 972.9 996.0 1027.9 2770.7 2849.7 382.5 387.6 430.8 433.0 450.7 10661.0 11234.6 11444.1 11451.6 11521.4 404.0 432.8 435.4 436.4 444.6 5804.8 5864.7 5927.7 5969.6 5991.3 511586.0 511608.0 514367.0 514417.0 531939.0 65238.0 66746.3 70181.6 73843.3 75516.2 458.5 464.0 466.0 466.6 467.1 9835.7 10199.2 10216.7 10252.9 10386.9 33452.5 33599.7 33618.5 34358.8 34471.5 44103.0 45369.8 45842.0 47490.8 47809.0 5711.6 5920.6 5954.2 5957.1 5962.6 9304.8 11073.0 11228.9 11373.1 11403.9 9471.9 9485.0 9516.9 9844.0 9848.3 9246.2 9474.0 9499.0 9514.6 9625.0 8360.5 9495.8 9499.1 9768.3 9830.8 5453.2 5526.6 5814.8 5865.8 5908.6 9702.4 9798.6 9808.6 9870.7 9906.5 08:34:12 INFO - 2015-11-09 08:34:12,897 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,898 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4574.37 Median:5715.83 stddev:2329.32 (40.8%) stddev-sans-first:2318.57 08:34:12 INFO - 2015-11-09 08:34:12,898 DEBUG : BROWSER_OUTPUT: Values: 800.8 1535.6 1614.1 1636.2 1647.8 6043.1 6322.0 6429.6 6430.7 6442.9 6455.5 6511.3 6567.8 6583.5 6586.4 1712.1 1747.0 1892.7 1915.3 1927.2 1951.8 1962.0 1963.5 1967.3 1968.2 1889.6 1900.5 1960.5 1960.6 1963.4 1881.7 1923.0 1938.5 1941.3 1943.2 1970.6 1984.8 1992.3 2001.0 2001.5 6574.3 6622.6 6647.0 6648.9 6658.2 4002.0 4072.5 4073.2 4081.4 4089.7 2235.7 2284.9 2331.0 2334.8 2375.0 684.3 688.6 700.8 737.3 751.8 8395.1 8400.4 8416.3 8423.5 8451.7 3629.5 3650.7 3681.7 3768.6 3773.0 7589.7 7596.3 7610.0 7611.1 7625.5 4159.6 4167.3 4171.8 4176.8 4177.1 3818.2 3821.0 3826.2 3834.2 3839.1 3168.3 3191.4 3218.3 3240.7 3252.1 999.0 1023.7 1027.3 1032.4 1035.1 1193.4 1205.8 1209.7 1227.5 1244.9 6282.0 6318.5 6366.0 6377.6 6385.7 432.4 440.6 440.8 443.5 448.6 5091.7 5098.8 5125.3 5130.1 5134.4 7507.7 7574.4 7623.0 7665.0 7681.4 7630.0 7641.7 7643.2 7649.7 7655.2 6177.5 6197.4 6199.3 6213.2 6240.8 5829.3 6004.8 6016.3 6030.7 6039.4 6865.5 6948.7 7012.9 7023.3 7057.4 6978.3 7108.2 7117.4 7125.4 7139.8 5693.3 5761.7 5761.8 5766.6 5799.2 6321.5 6408.6 6409.6 6410.3 6418.8 5621.8 5678.1 5757.6 5812.2 5816.3 5824.6 5831.0 5881.0 5900.6 5953.5 5738.3 5783.8 5792.3 5799.1 5858.2 5308.2 5310.6 5326.8 5335.1 5354.4 5145.7 5544.2 5570.7 5612.8 5620.2 08:34:12 INFO - 2015-11-09 08:34:12,898 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,899 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4909.68 Median:5646.46 stddev:1503.81 (26.6%) stddev-sans-first:1467.22 08:34:12 INFO - 2015-11-09 08:34:12,900 DEBUG : BROWSER_OUTPUT: Values: 273.9 290.6 295.4 306.8 309.5 5499.5 5588.5 5672.1 5683.0 5694.5 5474.2 5478.3 5535.3 5548.1 5598.8 4182.4 4205.0 4207.4 4219.3 4236.0 4150.4 4203.5 4215.8 4221.1 4229.6 4229.3 4250.4 4270.9 4272.7 4301.8 4247.0 4263.9 4282.9 4285.5 4286.8 3701.5 3701.9 3722.5 3725.9 3726.5 5263.1 5347.9 5425.3 5430.4 5453.8 4883.9 4886.9 4897.7 4910.4 4919.2 5880.6 5887.7 5890.8 5894.6 5906.3 4032.1 4043.0 4045.9 4052.7 4081.1 5950.2 6071.2 6110.8 6128.6 6135.0 3961.0 4003.6 4007.4 4010.5 4017.2 4052.0 4077.8 4113.1 4113.4 4125.5 4701.3 4729.1 4739.1 4740.5 4757.4 5727.3 5812.3 5878.1 5885.4 5908.6 1458.3 1481.8 1484.5 1485.0 1485.1 904.0 914.4 917.3 921.5 950.3 5579.2 5623.8 5629.4 5641.9 5651.0 6007.5 6128.9 6131.3 6142.9 6147.9 5533.9 5568.6 5603.4 5614.8 5616.1 3313.0 3356.8 3370.8 3375.6 3381.0 6105.5 6125.2 6144.4 6155.1 6157.3 6059.0 6243.0 6243.2 6250.7 6327.5 6202.1 6205.5 6215.4 6243.2 6258.6 6124.1 6142.8 6153.0 6167.7 6177.2 5884.7 6038.1 6047.0 6050.6 6054.7 6212.3 6218.1 6229.3 6232.4 6251.2 3804.6 3822.7 3832.2 3834.6 3858.9 5970.1 6110.3 6144.9 6158.8 6166.1 5973.9 5977.2 5991.8 5997.7 6006.2 5957.7 5958.8 5962.3 5966.7 6017.2 5655.8 5836.6 5856.6 5875.3 5878.2 5944.4 5982.2 6000.2 6001.1 6001.7 5806.5 5876.2 5888.5 5898.4 5911.7 08:34:12 INFO - 2015-11-09 08:34:12,900 DEBUG : BROWSER_OUTPUT: 08:34:12 INFO - 2015-11-09 08:34:12,900 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12598.32 Median:56460.43 stddev:15452.10 (27.4%) stddev-sans-first:15469.14 08:34:12 INFO - 2015-11-09 08:34:12,901 DEBUG : BROWSER_OUTPUT: Values: 589.7 627.2 647.3 715.7 731.4 12607.5 13169.2 13169.8 13185.0 13285.1 11441.9 12165.0 12301.6 12343.9 12349.0 845.1 862.0 864.2 866.9 868.5 850.1 862.5 864.0 864.0 865.7 885.0 889.8 891.0 891.7 892.0 882.8 885.2 885.3 885.3 885.7 655.6 655.7 655.9 656.1 656.3 12657.7 12702.7 12849.6 12938.7 12952.6 10371.6 10761.7 10803.7 11044.4 11638.4 8274.5 8447.7 8473.6 8489.1 8501.9 3009.5 3097.3 3097.7 3101.8 3107.6 40246.8 40904.6 43117.1 43335.8 45189.8 7875.4 7997.3 8050.9 8086.2 8393.1 16988.5 17002.5 17024.7 17053.3 17076.3 6090.5 6189.1 6505.7 6669.5 6697.9 3581.0 3679.2 3705.2 3707.7 3720.0 2721.3 2757.6 2762.2 2768.3 2774.7 397.2 397.9 405.6 408.9 411.4 377.5 442.0 477.7 496.4 517.6 6323.7 6473.6 6527.8 6552.1 6567.1 472.5 500.3 511.1 511.6 523.3 2930.5 3113.9 3222.3 3318.0 3410.4 55592.7 57328.1 57353.4 58118.0 58339.0 50144.5 50705.0 50710.7 50782.0 50978.2 37807.4 42959.8 43133.6 43478.0 43604.8 6794.5 6858.1 6932.0 7051.0 7196.6 34099.8 34120.3 34344.1 34522.3 34720.1 40694.0 42115.4 43816.8 44323.0 44635.8 6744.3 6770.6 6778.0 6845.3 6937.8 9936.8 10026.1 10098.2 10149.1 10215.3 9176.7 9358.0 9472.1 9708.7 9877.1 9632.6 9686.6 9713.0 9796.0 10319.2 8662.0 8719.5 8960.2 9025.0 9317.5 8368.7 8515.2 8553.1 8663.7 8797.7 7761.6 8259.8 8325.7 8414.8 8472.4 08:34:12 INFO - 2015-11-09 08:34:12,901 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:34:12 INFO - 2015-11-09 08:34:12,902 DEBUG : BROWSER_OUTPUT: 08:34:13 INFO - 2015-11-09 08:34:13,599 INFO : Browser exited with error code: 0 08:34:13 INFO - 2015-11-09 08:34:13,629 INFO : Completed test dromaeo_css (00:18:34) 08:34:13 INFO - 2015-11-09 08:34:13,629 INFO : Starting test kraken 08:34:13 INFO - 2015-11-09 08:34:13,629 DEBUG : operating with platform_type : mac_ 08:34:13 INFO - 2015-11-09 08:34:13,629 INFO : Initialising browser for kraken test... 08:34:13 INFO - 2015-11-09 08:34:13,643 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmplQSmkc/profile http://localhost:49795/getInfo.html 08:34:15 INFO - 2015-11-09 08:34:15,962 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:34:15 INFO - 2015-11-09 08:34:15,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:34:15 INFO - 2015-11-09 08:34:15,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:34:15 INFO - 2015-11-09 08:34:15,963 DEBUG : BROWSER_OUTPUT: __metrics 08:34:15 INFO - 2015-11-09 08:34:15,978 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:16 INFO - 2015-11-09 08:34:16,721 INFO : Browser initialized. 08:34:16 INFO - 2015-11-09 08:34:16,721 INFO : Running cycle 1/1 for kraken test... 08:34:16 INFO - 2015-11-09 08:34:16,722 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmplQSmkc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:34:28 INFO - 2015-11-09 08:34:28,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 199716864 08:34:28 INFO - 2015-11-09 08:34:28,699 DEBUG : BROWSER_OUTPUT: 08:34:31 INFO - 2015-11-09 08:34:31,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:31 INFO - 2015-11-09 08:34:31,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 267468800 08:34:31 INFO - 2015-11-09 08:34:31,882 DEBUG : BROWSER_OUTPUT: 08:34:34 INFO - 2015-11-09 08:34:34,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-dft) 08:34:35 INFO - 2015-11-09 08:34:35,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 281604096 08:34:35 INFO - 2015-11-09 08:34:35,284 DEBUG : BROWSER_OUTPUT: 08:34:38 INFO - 2015-11-09 08:34:38,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-fft) 08:34:38 INFO - 2015-11-09 08:34:38,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 269221888 08:34:38 INFO - 2015-11-09 08:34:38,903 DEBUG : BROWSER_OUTPUT: 08:34:41 INFO - 2015-11-09 08:34:41,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49795/tests/kraken/driver.html?testName=audio-oscillator) 08:34:41 INFO - 2015-11-09 08:34:41,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 271876096 08:34:41 INFO - 2015-11-09 08:34:41,630 DEBUG : BROWSER_OUTPUT: 08:34:43 INFO - 2015-11-09 08:34:43,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:44 INFO - 2015-11-09 08:34:44,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 270921728 08:34:44 INFO - 2015-11-09 08:34:44,538 DEBUG : BROWSER_OUTPUT: 08:34:47 INFO - 2015-11-09 08:34:47,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:48 INFO - 2015-11-09 08:34:48,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 271884288 08:34:48 INFO - 2015-11-09 08:34:48,435 DEBUG : BROWSER_OUTPUT: 08:34:51 INFO - 2015-11-09 08:34:51,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49795/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:52 INFO - 2015-11-09 08:34:52,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 272318464 08:34:52 INFO - 2015-11-09 08:34:52,360 DEBUG : BROWSER_OUTPUT: 08:34:55 INFO - 2015-11-09 08:34:55,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49795/tests/kraken/driver.html?testName=json-parse-financial) 08:34:56 INFO - 2015-11-09 08:34:56,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 271998976 08:34:56 INFO - 2015-11-09 08:34:56,026 DEBUG : BROWSER_OUTPUT: 08:34:57 INFO - 2015-11-09 08:34:57,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:58 INFO - 2015-11-09 08:34:58,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 302903296 08:34:58 INFO - 2015-11-09 08:34:58,262 DEBUG : BROWSER_OUTPUT: 08:35:00 INFO - 2015-11-09 08:35:00,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:00 INFO - 2015-11-09 08:35:00,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 305233920 08:35:00 INFO - 2015-11-09 08:35:00,790 DEBUG : BROWSER_OUTPUT: 08:35:02 INFO - 2015-11-09 08:35:02,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:03 INFO - 2015-11-09 08:35:03,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 310595584 08:35:03 INFO - 2015-11-09 08:35:03,575 DEBUG : BROWSER_OUTPUT: 08:35:06 INFO - 2015-11-09 08:35:06,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:06 INFO - 2015-11-09 08:35:06,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 311664640 08:35:06 INFO - 2015-11-09 08:35:06,894 DEBUG : BROWSER_OUTPUT: 08:35:09 INFO - 2015-11-09 08:35:09,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:10 INFO - 2015-11-09 08:35:10,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 312438784 08:35:10 INFO - 2015-11-09 08:35:10,226 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49795/tests/kraken/driver.html?testName=ai-astar) 08:35:12 INFO - 2015-11-09 08:35:12,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 370671616 08:35:12 INFO - 2015-11-09 08:35:12,291 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,293 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:35:12 INFO - 2015-11-09 08:35:12,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:35:12 INFO - 2015-11-09 08:35:12,293 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:35:12 INFO - 2015-11-09 08:35:12,293 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;108;112;114;111;117;114;115;109 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;139;169;168;143;168;140;177;166;140 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |2;audio-dft;172;181;180;174;175;174;181;182;176;175 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;85;89;135;74;77;79;80;130;72 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;102;153;99;100;99;144;99;97;141 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;137;137;124;135;135;135;130;135;136;136 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;134;140;140;140;139;134;140;140;141;138 08:35:12 INFO - 2015-11-09 08:35:12,294 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;112;114;113;112;114;114;112;111;110 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;63;65;66;66;70;69;78;63;65 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;69;71;74;73;74;74;75;75;72 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;91;93;98;91;95;91;92;93;97 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;140;137;138;135;133;130;140;142;141 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;164;160;162;161;162;162;153;159;162 08:35:12 INFO - 2015-11-09 08:35:12,295 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;74;74;77;77;78;77;78;76;77 08:35:12 INFO - 2015-11-09 08:35:12,296 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:35:12 INFO - 2015-11-09 08:35:12,297 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:35:12 INFO - 2015-11-09 08:35:12,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 08:35:12 INFO - 2015-11-09 08:35:12,297 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:35:12 INFO - 2015-11-09 08:35:12,297 DEBUG : BROWSER_OUTPUT: __startTimestamp1447086912292__endTimestamp 08:35:12 INFO - 2015-11-09 08:35:12,297 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,298 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:35:12 INFO - 2015-11-09 08:35:12,298 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:35:12 INFO - 2015-11-09 08:35:12,298 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,298 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:114.00 stddev:3.36 (2.9%) stddev-sans-first:3.41 08:35:12 INFO - 2015-11-09 08:35:12,298 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 108.0 112.0 114.0 111.0 117.0 114.0 115.0 109.0 08:35:12 INFO - 2015-11-09 08:35:12,299 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,299 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:156.50 Median:167.00 stddev:14.78 (8.9%) stddev-sans-first:15.67 08:35:12 INFO - 2015-11-09 08:35:12,299 DEBUG : BROWSER_OUTPUT: Values: 155.0 139.0 169.0 168.0 143.0 168.0 140.0 177.0 166.0 140.0 08:35:12 INFO - 2015-11-09 08:35:12,299 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,299 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:177.00 Median:178.00 stddev:3.62 (2.0%) stddev-sans-first:3.36 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: Values: 172.0 181.0 180.0 174.0 175.0 174.0 181.0 182.0 176.0 175.0 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:79.50 stddev:22.86 (28.7%) stddev-sans-first:24.00 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 89.0 135.0 74.0 77.0 79.0 80.0 130.0 72.0 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,300 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:113.80 Median:125.00 stddev:22.49 (18.0%) stddev-sans-first:23.58 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: Values: 104.0 102.0 153.0 99.0 100.0 99.0 144.0 99.0 97.0 141.0 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:134.00 Median:135.50 stddev:4.03 (3.0%) stddev-sans-first:4.12 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 124.0 135.0 135.0 135.0 130.0 135.0 136.0 136.0 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:138.60 Median:140.00 stddev:2.55 (1.8%) stddev-sans-first:2.09 08:35:12 INFO - 2015-11-09 08:35:12,301 DEBUG : BROWSER_OUTPUT: Values: 134.0 140.0 140.0 140.0 139.0 134.0 140.0 140.0 141.0 138.0 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:112.50 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: Values: 113.0 112.0 114.0 113.0 112.0 114.0 114.0 112.0 111.0 110.0 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:5.29 (8.0%) stddev-sans-first:4.68 08:35:12 INFO - 2015-11-09 08:35:12,303 DEBUG : BROWSER_OUTPUT: Values: 58.0 63.0 65.0 66.0 66.0 70.0 69.0 78.0 63.0 65.0 08:35:12 INFO - 2015-11-09 08:35:12,304 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,304 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:74.00 stddev:3.16 (4.3%) stddev-sans-first:2.00 08:35:12 INFO - 2015-11-09 08:35:12,304 DEBUG : BROWSER_OUTPUT: Values: 65.0 69.0 71.0 74.0 73.0 74.0 74.0 75.0 75.0 72.0 08:35:12 INFO - 2015-11-09 08:35:12,304 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,304 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:93.00 stddev:3.43 (3.7%) stddev-sans-first:2.65 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: Values: 86.0 91.0 93.0 98.0 91.0 95.0 91.0 92.0 93.0 97.0 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:139.00 stddev:4.79 (3.4%) stddev-sans-first:4.00 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: Values: 128.0 140.0 137.0 138.0 135.0 133.0 130.0 140.0 142.0 141.0 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:162.00 stddev:4.03 (2.5%) stddev-sans-first:3.17 08:35:12 INFO - 2015-11-09 08:35:12,305 DEBUG : BROWSER_OUTPUT: Values: 152.0 164.0 160.0 162.0 161.0 162.0 162.0 153.0 159.0 162.0 08:35:12 INFO - 2015-11-09 08:35:12,306 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,307 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:77.00 stddev:2.49 (3.2%) stddev-sans-first:1.51 08:35:12 INFO - 2015-11-09 08:35:12,307 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 74.0 77.0 77.0 78.0 77.0 78.0 76.0 77.0 08:35:12 INFO - 2015-11-09 08:35:12,307 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:35:12 INFO - 2015-11-09 08:35:12,307 DEBUG : BROWSER_OUTPUT: 08:35:12 INFO - 2015-11-09 08:35:12,969 INFO : Browser exited with error code: 0 08:35:13 INFO - 2015-11-09 08:35:13,021 INFO : Completed test kraken (00:00:59) 08:35:13 INFO - 2015-11-09 08:35:13,021 INFO : Starting test v8_7 08:35:13 INFO - 2015-11-09 08:35:13,021 DEBUG : operating with platform_type : mac_ 08:35:13 INFO - 2015-11-09 08:35:13,022 INFO : Initialising browser for v8_7 test... 08:35:13 INFO - 2015-11-09 08:35:13,035 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpdJ1Va7/profile http://localhost:49795/getInfo.html 08:35:15 INFO - 2015-11-09 08:35:15,349 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:35:15 INFO - 2015-11-09 08:35:15,350 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:35:15 INFO - 2015-11-09 08:35:15,350 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:35:15 INFO - 2015-11-09 08:35:15,350 DEBUG : BROWSER_OUTPUT: __metrics 08:35:15 INFO - 2015-11-09 08:35:15,369 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:16 INFO - 2015-11-09 08:35:16,082 INFO : Browser initialized. 08:35:16 INFO - 2015-11-09 08:35:16,083 INFO : Running cycle 1/1 for v8_7 test... 08:35:16 INFO - 2015-11-09 08:35:16,083 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/T/tmpdJ1Va7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:35:28 INFO - 2015-11-09 08:35:28,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 200204288 08:35:28 INFO - 2015-11-09 08:35:28,034 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49795/tests/v8_7/run.html (next: http://localhost:49795/tests/v8_7/run.html) 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 519352320 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: |0;Richards;173.94329448599757 08:35:50 INFO - 2015-11-09 08:35:50,818 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;209.07380305247753 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |2;Encrypt;352.7336860670194 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6329.113924050633 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1116.0714285714287 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |5;Earley;783.2550860719875 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |6;Boyer;13849.315068493152 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |7;RegExp;32306.451612903227 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |8;Splay;678.42605156038 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6327.044025157233 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: __startTimestamp1447086950815__endTimestamp 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:35:50 INFO - 2015-11-09 08:35:50,819 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.94 Median:173.94 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: Values: 173.9 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:209.07 Median:209.07 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: Values: 209.1 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:352.73 Median:352.73 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: Values: 352.7 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6329.11 Median:6329.11 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: Values: 6329.1 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1116.07 Median:1116.07 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,820 DEBUG : BROWSER_OUTPUT: Values: 1116.1 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.26 Median:783.26 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: Values: 783.3 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13849.32 Median:13849.32 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: Values: 13849.3 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32306.45 Median:32306.45 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: Values: 32306.5 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:678.43 Median:678.43 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,821 DEBUG : BROWSER_OUTPUT: Values: 678.4 08:35:50 INFO - 2015-11-09 08:35:50,822 DEBUG : BROWSER_OUTPUT: 08:35:50 INFO - 2015-11-09 08:35:50,822 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6327.04 Median:6327.04 stddev:0.00 (0.0%) 08:35:50 INFO - 2015-11-09 08:35:50,822 DEBUG : BROWSER_OUTPUT: Values: 6327.0 08:35:50 INFO - 2015-11-09 08:35:50,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:35:50 INFO - 2015-11-09 08:35:50,822 DEBUG : BROWSER_OUTPUT: 08:35:51 INFO - 2015-11-09 08:35:51,501 INFO : Browser exited with error code: 0 08:35:51 INFO - 2015-11-09 08:35:51,523 INFO : Completed test v8_7 (00:00:38) 08:35:51 INFO - 2015-11-09 08:35:51,894 INFO : Completed test suite (00:20:12) 08:35:51 INFO - 2015-11-09 08:35:51,895 DEBUG : Working with test: dromaeo_css 08:35:51 INFO - 2015-11-09 08:35:51,895 DEBUG : Generating results file: dromaeo_css 08:35:51 INFO - 2015-11-09 08:35:51,895 DEBUG : Working with test: kraken 08:35:51 INFO - 2015-11-09 08:35:51,896 DEBUG : Generating results file: kraken 08:35:51 INFO - 2015-11-09 08:35:51,896 INFO : javascript benchmark 08:35:51 INFO - 2015-11-09 08:35:51,896 DEBUG : Working with test: v8_7 08:35:51 INFO - 2015-11-09 08:35:51,896 DEBUG : Generating results file: v8_7 08:35:51 INFO - 2015-11-09 08:35:51,896 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:51 INFO - 2015-11-09 08:35:51,960 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 08:35:51 INFO - 2015-11-09 08:35:51,960 DEBUG : process_Request line: dromaeo_css 6106.56 graph.html#tests=[[72,52,55]] 08:35:51 INFO - 2015-11-09 08:35:51,960 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:51 INFO - 2015-11-09 08:35:51,994 DEBUG : process_Request line: kraken 1637.90 graph.html#tests=[[232,52,55]] 08:35:51 INFO - 2015-11-09 08:35:51,994 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:35:52 INFO - 2015-11-09 08:35:52,027 DEBUG : process_Request line: v8_7 18468.46 graph.html#tests=[[230,52,55]] 08:35:52 INFO - 2015-11-09 08:35:52,028 INFO : javascript benchmark 08:35:52 INFO - 2015-11-09 08:35:52,030 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [305.8272076276905, 313.9105354973833, 319.68511016648597, 321.7313543191435, 329.2066120649235, 13473.528426505074, 13900.582982510516, 16596.25316860741, 16830.49508514745, 17202.225899834506, 13999.0, 14113.64715882101, 15608.921955390235, 16539.338426462928, 16580.50258492244, 4890.731009794469, 5010.3737032870895, 5013.949860501403, 5025.447200807908, 5051.06555287273, 3673.9081522961874, 4950.480199579047, 5012.624053196007, 5014.799408023675, 5022.397312322526, 4970.676906001117, 5179.948200517984, 5350.705711185883, 5354.0, 5368.0605893968595, 4313.09425020746, 4430.847979525314, 5287.894242115155, 5307.787688492455, 5332.120200166968, 3747.0, 3762.849486020556, 3763.0404246917133, 3768.3028639701743, 3782.867599634, 12446.626601201979, 12448.875511244862, 12671.17637353569, 12703.936480317632, 12715.55495557651, 1621.2218135295125, 1704.1649591700102, 1720.096949101719, 1764.1796564597523, 1842.3183422133761, 8879.822403551958, 8981.640734370618, 9036.548172591343, 9270.721878343593, 9333.06669333068, 1363.3183408295852, 1398.2100113435877, 1403.3474434387956, 1424.7293014327245, 1437.9712405751932, 54006.45993540053, 54693.453065469235, 55579.44420555783, 55657.99999999959, 56388.43611563914, 6051.727672254759, 6102.145699602059, 6116.449519543263, 6139.662318572521, 6145.078238264206, 7028.437724981989, 7032.718691252395, 7036.683349249296, 7047.541909775849, 7081.37128460457, 5206.140986737221, 5207.895842083137, 5222.3472065991755, 5227.738613069331, 5249.107651699221, 5607.579431542651, 5625.240592520039, 5661.179129026351, 5663.433656634304, 5672.829815105553, 2727.8772455239564, 2742.0951086141527, 2766.4467106578763, 2768.792340574465, 2777.180731684158, 972.8666103988916, 996.038822536256, 1027.8509616105623, 2770.667519897585, 2849.7292757188034, 382.4664592892899, 387.5504414878727, 430.8039841871941, 433.02137169996035, 450.682269000354, 10660.987191253316, 11234.606788762354, 11444.084473242287, 11451.59919402817, 11521.366324852213, 403.9939400908989, 432.8182163491341, 435.3991491741377, 436.3585529271965, 444.63539897283914, 5804.767809287666, 5864.70676466175, 5927.673977931255, 5969.611975221596, 5991.310999235144, 511586.0, 511608.0, 514367.0, 514417.0, 531939.0, 65238.0, 66746.33253667498, 70181.64909175523, 73843.26156738472, 75516.24483755202, 458.46130796314196, 464.02786162988485, 465.9743714095757, 466.55677106748726, 467.05421521419396, 9835.704928852147, 10199.184065274612, 10216.693499195037, 10252.897471025493, 10386.896131038593, 33452.498212527316, 33599.664003359656, 33618.49572256369, 34358.82820585881, 34471.4829277566, 44103.0, 45369.773151135356, 45842.0, 47490.76254618705, 47809.04381912412, 5711.571632127524, 5920.555958303058, 5954.166416701752, 5957.106434034929, 5962.642241465526, 9304.813903721752, 11073.0, 11228.922649309903, 11373.14701397382, 11403.885961140282, 9471.857922131312, 9484.95257523708, 9516.857247141437, 9843.950780246052, 9848.261380396641, 9246.214071803972, 9473.952630236805, 9499.0, 9514.619415223591, 9625.0, 8360.45657032291, 9495.762605934908, 9499.145076943109, 9768.26737994639, 9830.75423114428, 5453.2365468833605, 5526.585506086979, 5814.825555233349, 5865.794697185578, 5908.586398952204, 9702.417854928726, 9798.559064842242, 9808.558614862206, 9870.654527091518, 9906.455144967096], "dojo.html": [2957.171991842285, 2989.4768415527305, 2997.4304882072406, 3017.8491075446236, 3155.589773329467, 5031.320771695825, 5064.0, 5068.391792984838, 5094.108531007073, 5101.464346243637, 4898.730569818658, 5044.319016932713, 5115.079285728568, 5167.173252279636, 5255.684658920468, 4387.890302742425, 4498.302763071729, 4656.231721765913, 4689.991651794863, 4753.144434001878, 4573.519780423041, 4633.374494443257, 4699.130660827758, 4778.880527986811, 4789.568938795508, 4754.6196304295745, 4766.094442056015, 4782.736949467778, 4784.473707892129, 4805.567498925096, 4352.0, 4725.740084295362, 4734.857954261343, 4747.643926705494, 4804.1352556539805, 4553.977230113828, 4599.816007359702, 4624.028953919647, 4639.095376401603, 4654.441467023945, 4924.778384972685, 4951.678140920829, 4990.65065445419, 5001.724905130216, 5087.313212716273, 5216.035033518811, 5315.681059136426, 5327.094393953037, 5341.43914888935, 5342.439043900374, 5403.243545903538, 5460.208269800896, 5473.233747275384, 5513.972430137864, 5520.613557051008, 5143.948560514422, 5192.92210616841, 5192.974035129876, 5219.060569097523, 5232.39827419844, 5240.580753539708, 5623.381428042912, 5673.858153546194, 5691.686957217393, 5710.600257981901, 5053.469385714447, 5087.720175390389, 5183.170692689227, 5268.420473747885, 5290.497402746733, 5464.754086066137, 5467.972660136754, 5471.37079235885, 5475.917861232085, 5477.643953143112, 5031.496850314939, 5335.093034184198, 5346.304980352529, 5363.356397232357, 5409.161579955114, 5110.310108135429, 5170.353705786777, 5205.791768329224, 5234.502722241381, 5245.0558899398475, 4121.835126594902, 4138.91722165555, 4141.088960428701, 4155.58444155582, 4161.979190104091, 3627.8004709741217, 3786.1481166737813, 3793.3551296279697, 3797.0, 3808.27642747877, 4895.31465594817, 4977.950220497821, 4999.350084489066, 5014.122528557488, 5020.2720605511995, 5554.666719996732, 5555.555555555546, 5563.638363506359, 5597.552195824324, 5608.803691870847, 4789.568938795525, 5116.692998420107, 5132.743362831919, 5142.202958541432, 5163.845084647466, 4662.0, 4734.147853386424, 4734.431868175841, 4758.357621721093, 4774.164521208774, 5578.97210513953, 5611.551075913835, 5617.9719101404235, 5623.072193088258, 5631.070873305859, 5216.0, 5574.136008918624, 5575.386707462257, 5581.49766521015, 5586.413426590312, 5506.752196151103, 5520.889582208253, 5544.473275038865, 5605.383407825218, 5637.098064309691, 5449.155380915964, 5474.124140137559, 5480.424555421623, 5503.394626590992, 5526.972365138148, 5289.20661900718, 5523.861903452285, 5536.806211782729, 5560.749766260447, 5570.805021824217, 5064.949350506447, 5077.7715002824225, 5106.642535022513, 5132.948670513247, 5134.409542902465, 5264.9210261846865, 5398.892022159614, 5405.216243644571, 5414.431484694208, 5461.590380721383, 5103.591712662904, 5273.129933560919, 5300.761465734128, 5314.840554783363, 5336.813211537577, 5236.921446178234, 5283.920741188808, 5304.787808487617, 5329.520343169133, 5371.62398632092, 5193.532582067632, 5201.193814958688, 5218.582513398995, 5220.660657057279, 5247.658902171346], "mootools.html": [800.7998000499875, 1535.6391248056705, 1614.0557773702392, 1636.23914879581, 1647.8269781672925, 6043.123747056674, 6321.968390158048, 6429.614223146608, 6430.678466076701, 6442.935570644304, 6455.451286640629, 6511.28375878653, 6567.802965911018, 6583.473322134229, 6586.4401525870235, 1712.1182590965664, 1746.97379539307, 1892.7444794952712, 1915.2913422033866, 1927.2194761121698, 1951.7657881054222, 1962.0484065228352, 1963.4894927318858, 1967.2622766462578, 1968.2323893681476, 1889.5842914558775, 1900.5153685810099, 1960.5196726801953, 1960.5784756277399, 1963.3717210492648, 1881.6707076261737, 1922.951926201842, 1938.5153711572107, 1941.2720229913782, 1943.24213556713, 1970.5861769028377, 1984.811442912921, 1992.3325685895243, 2000.9699854502048, 2001.539645881441, 6574.309697481791, 6622.569532980341, 6647.0, 6648.867022659568, 6658.201015878077, 4001.9599804001878, 4072.5112986441522, 4073.185362927397, 4081.3673880548563, 4089.652379547742, 2235.7205349331334, 2284.931452056441, 2330.953380932372, 2334.8248881333966, 2375.0381095656285, 684.3498676257525, 688.6384648059759, 700.8247938015496, 737.2885165814961, 751.8345963887936, 8395.118512556215, 8400.41197116202, 8416.326693864537, 8423.452475589067, 8451.661933522651, 3629.491871138043, 3650.6896913762625, 3681.723870709654, 3768.6042965488778, 3773.0, 7589.734359297398, 7596.316331530189, 7610.0, 7611.086669599684, 7625.542467451971, 4159.584041595876, 4167.333226683716, 4171.812268447927, 4176.791160441966, 4177.060161463707, 3818.1981783825154, 3820.9617903820604, 3826.196498735241, 3834.194819087967, 3839.078621130964, 3168.287135394564, 3191.393635209303, 3218.3241519280746, 3240.740740740735, 3252.10567094051, 998.960041598328, 1023.7133602591138, 1027.342500799489, 1032.3702541449709, 1035.0994634667736, 1193.40926241511, 1205.813098969661, 1209.7459533497888, 1227.533537255837, 1244.8630650628425, 6281.96859015702, 6318.462930650946, 6366.045093235959, 6377.649229292433, 6385.680715964183, 432.37305906435796, 440.63867628544284, 440.8324836562086, 443.4855567541636, 448.614191795056, 5091.66904151229, 5098.847034588968, 5125.333706618116, 5130.050940576006, 5134.409542902614, 7507.699692012258, 7574.356179724675, 7623.047119110111, 7664.961675191588, 7681.3854891608535, 7630.008098947213, 7641.69433222676, 7643.235676432423, 7649.655765490566, 7655.234476552411, 6177.505799536116, 6197.380261973766, 6199.3490683478485, 6213.2233470816145, 6240.843978900473, 5829.271341082364, 6004.849878753066, 6016.278046634432, 6030.7286172121485, 6039.4262545058145, 6865.450763938973, 6948.687309071003, 7012.894806578008, 7023.33278338557, 7057.400120989568, 6978.267281935324, 7108.218096009538, 7117.43060555144, 7125.394341481032, 7139.785806425815, 5693.345265294544, 5761.740721667619, 5761.827145185651, 5766.567507437043, 5799.159121927381, 6321.494280457644, 6408.647524386203, 6409.583377080475, 6410.262819775786, 6418.839529011625, 5621.80323688669, 5678.119891416837, 5757.625754325955, 5812.244408226903, 5816.272965879265, 5824.563157763269, 5831.037878750129, 5880.970595147168, 5900.64596124234, 5953.493953014043, 5738.311402631711, 5783.797567085132, 5792.333881603669, 5799.130130480462, 5858.209141765807, 5308.230306605444, 5310.575153987749, 5326.760295786621, 5335.06636338647, 5354.3574771027725, 5145.691258524501, 5544.1960915667805, 5570.749316280858, 5612.803551875665, 5620.213170156099], "ext.html": [522.034236662175, 524.4074196158341, 525.2384043137451, 525.4141632080232, 548.2954403591386, 30587.847060764692, 31579.052628421156, 36889.63110368895, 37315.253694926156, 37331.813340933324, 39340.0, 39847.40228896569, 39971.00072498189, 40033.79983100088, 40045.19909601806, 7829.647665855022, 8412.831743365145, 8600.311975042014, 8614.698485553006, 8621.61202745878, 7995.920040799605, 10208.0, 10454.372737635727, 10475.161987041018, 10487.318324308933, 10119.848202276971, 10284.485775711222, 10303.27877048607, 10323.53544090514, 10358.637447689332, 8031.317338026275, 8186.795330116735, 10096.747581310452, 10231.897681023207, 10345.844812327821, 10016.09855113036, 10145.695629131138, 10152.492375381202, 10160.33957792741, 10225.437600931946, 37853.432198517046, 38281.234375312335, 38332.425013624816, 38375.61624383748, 38426.42360364597, 2733.7129601391766, 2845.2460098074025, 3038.3923215357017, 3206.1183174627163, 3225.0647312279643, 26001.0, 26193.214203573923, 26303.0, 26536.203913882615, 26712.46575068507, 2104.3371338028473, 2141.486043349585, 2167.783221677835, 2174.3150907464255, 2182.7598964114095, 244766.0, 249023.0, 249330.0, 249926.0, 250662.0, 51545.48454515482, 52648.0, 60003.499737518985, 60296.39703602996, 60401.0, 69347.65326173337, 70030.0, 70211.0, 70621.0, 70648.2935170652, 16337.18314084291, 16347.918260408622, 16571.25429355682, 16595.91702041482, 16617.750733739005, 12521.436535355931, 12538.623841284776, 12589.622311330491, 12617.49530018789, 12617.810732839014, 19168.632603696948, 19429.72470496999, 19430.304235434425, 19531.316403925794, 19593.412197634094, 7838.372930165573, 7973.521588704581, 8005.399595030396, 8015.438919275594, 8020.79948001293, 837.7403005068448, 870.6691457246333, 939.7791518993031, 953.7949340891741, 960.582146766159, 24702.13542526003, 25228.0, 25667.0, 26090.0, 26370.73629263683, 895.7581453007782, 976.3556053004983, 1001.7878367175799, 1083.106437189322, 1133.019937753837, 10512.579496820195, 13487.05590608648, 13567.59297221085, 13735.587932362045, 13812.171269723849, 305534.0, 308341.0, 309010.0, 310628.0, 312064.0, 46391.30413043807, 47469.28796068062, 51878.0, 53258.46741532535, 53425.0, 1263.873612638747, 1265.7658333208385, 1296.461968283152, 1298.9932802078276, 1299.493197652916, 24903.377415564755, 25224.747752522973, 26125.73874261309, 26140.86929565416, 26261.0, 41978.580214197464, 42349.0, 42390.36414453724, 42441.36337954995, 42733.14533709371, 252567.0, 254400.0, 255341.0, 255413.0, 255871.0, 28518.0, 28994.27514312159, 29325.560116598695, 29353.706462935097, 29356.706432935396, 40174.79912600418, 40278.38190517607, 41150.38274425826, 41565.584344156174, 41650.166996660504, 31862.522062169548, 34020.0, 34174.31651366909, 34557.30885382228, 34840.65159348374, 33833.66166338305, 34240.657593424745, 34293.0, 34729.82635086808, 35951.820240898625, 32817.34365312633, 33519.329613407106, 33798.0, 33805.492917606745, 33856.322873542886, 28338.43323133567, 29210.269743256587, 29733.405331893675, 29902.850485747433, 30008.0, 21649.35051948444, 22491.0, 22821.771782282627, 22905.65641515412, 23078.60240342131], "prototype.html": [273.8794930230698, 290.55835130601486, 295.4386665335862, 306.771455265827, 309.53260576529436, 5499.50504454599, 5588.497035266825, 5672.149177623359, 5682.971585142079, 5694.515966142878, 5474.178873169027, 5478.342598888129, 5535.335759708831, 5548.0845660466075, 5598.832035038945, 4182.414461975318, 4205.03284244624, 4207.410962465257, 4219.324908014718, 4236.04688944988, 4150.418941348214, 4203.47456567929, 4215.810288537024, 4221.134667393192, 4229.598188172119, 4229.34445160999, 4250.404943307939, 4270.935935960963, 4272.679549033819, 4301.784910754465, 4247.044415006599, 4263.936040959388, 4282.850100246492, 4285.46431696038, 4286.785660716982, 3701.5188025556504, 3701.8519259229597, 3722.4788529605876, 3725.925481490382, 3726.4782930389765, 5263.054303540816, 5347.866303342447, 5425.348958125051, 5430.402655707869, 5453.781848726086, 4883.902321953577, 4886.877828054292, 4897.681650692693, 4910.361652985089, 4919.237518184651, 5880.558958078162, 5887.705614719247, 5890.823275301748, 5894.557908156906, 5906.320773111104, 4032.052467670095, 4042.9595704042877, 4045.8786236412957, 4052.716309858311, 4081.08175660477, 5950.196723442366, 6071.210742603434, 6110.816675499742, 6128.632282063046, 6135.049067394561, 3960.960390396117, 4003.579624139482, 4007.3788562772233, 4010.478637777129, 4017.1563971566297, 4051.9797401012806, 4077.7961101944784, 4113.095119073799, 4113.382992551082, 4125.525564560054, 4701.341812146302, 4729.0541891621815, 4739.052189562101, 4740.478547359788, 4757.405324334458, 5727.284089488814, 5812.273465816773, 5878.147668588116, 5885.382034886361, 5908.645481271052, 1458.2854401343266, 1481.799957005812, 1484.4730120807174, 1485.049568276304, 1485.1460410264142, 903.9909600903907, 914.4421902639384, 917.3440989692402, 921.5346250143634, 950.3157726436955, 5579.218909352694, 5623.831285061455, 5629.408912064257, 5641.915371269434, 5651.011073062197, 6007.549433792483, 6128.908066379008, 6131.264248290234, 6142.938570614326, 6147.877042459126, 5533.889322213533, 5568.610197286151, 5603.411641777636, 5614.803481878196, 5616.073347897551, 3312.966870331266, 3356.848941797625, 3370.764046516769, 3375.561177046968, 3380.9857042887033, 6105.45050945417, 6125.203723515914, 6144.354842741537, 6155.138280640714, 6157.291911430153, 6059.0, 6243.0, 6243.219597550306, 6250.6874656267, 6327.525435592349, 6202.131701561785, 6205.503559715122, 6215.440610345091, 6243.219597550306, 6258.561900666909, 6124.081387791867, 6142.815715528542, 6152.984757515139, 6167.6916154193, 6177.1969643945995, 5884.676342801187, 6038.094285857156, 6046.969765151146, 6050.6369617823075, 6054.727537260922, 6212.316645169119, 6218.129461875251, 6229.345918678474, 6232.376762323732, 6251.187345645037, 3804.5624753152633, 3822.6941844652915, 3832.1952389997296, 3834.5973672763957, 3858.9035274118373, 5970.0746384310505, 6110.2973158085615, 6144.877102457836, 6158.753649853956, 6166.075088736726, 5973.940260597338, 5977.193078934288, 5991.7603295867675, 5997.670128142994, 6006.249218847644, 5957.672328021827, 5958.76164953397, 5962.25471816023, 5966.701664916824, 6017.157597936205, 5655.773769049192, 5836.620619659709, 5856.619319744203, 5875.265591801025, 5878.177055212188, 5944.405559444194, 5982.192404025401, 6000.249968753906, 6001.099835024781, 6001.669908155093, 5806.506446952057, 5876.1773351731645, 5888.528917686661, 5898.351181370132, 5911.733971971357], "yui.html": [589.7257775134565, 627.1627377451102, 647.258888572584, 715.7029832619463, 731.4112139727517, 12607.495700171994, 13169.209847409138, 13169.802452963213, 13185.011124165678, 13285.070045096847, 11441.885581144186, 12165.0, 12301.630951071482, 12343.876561234385, 12349.0, 845.0619812008681, 862.0302160069921, 864.1660797330575, 866.9393142480029, 868.5179725252482, 850.0564373545391, 862.5126803356115, 863.9891327147253, 864.0279685353977, 865.7186414415308, 884.9778505825782, 889.7775556110972, 890.9931777091878, 891.6700820696351, 891.9866202006975, 882.8322618702426, 885.1590988560893, 885.2740752582885, 885.3094586222757, 885.6988623867851, 655.596807963104, 655.6951017776756, 655.8884989551788, 656.0880376276979, 656.2879275985562, 12657.683557911034, 12702.682432939158, 12849.614511564669, 12938.676533086655, 12952.611421657366, 10371.585136594527, 10761.730956726065, 10803.729906752316, 11044.392558409285, 11638.41807909601, 8274.544900030496, 8447.662093516252, 8473.576321183917, 8489.066202717697, 8501.914980850173, 3009.5184770436626, 3097.349556593118, 3097.7366923811505, 3101.8449077546256, 3107.564940908275, 40246.79876600627, 40904.59095409067, 43117.11945924882, 43335.78332108351, 45189.77405112986, 7875.409344299201, 7997.280244777881, 8050.919490805134, 8086.15095414973, 8393.076761556224, 16988.49034528966, 17002.48992530226, 17024.744628830576, 17053.317867285168, 17076.316947322215, 6090.451859332681, 6189.071639254058, 6505.70985129097, 6669.466442684574, 6697.866042679217, 3581.0, 3679.2089700714473, 3705.2404257127223, 3707.6848467879995, 3719.9956011876643, 2721.3468767496056, 2757.6139340492346, 2762.1713485954533, 2768.335599456116, 2774.680911695181, 397.23333965446966, 397.9204159168178, 405.5842761169766, 408.88142438692444, 411.4198979438977, 377.45269359428937, 441.99558004420186, 477.7372445155151, 496.44894167474075, 517.6350672775684, 6323.652199129, 6473.611583305017, 6527.771527996498, 6552.115464412243, 6567.080608714784, 472.4684729679111, 500.31207090250905, 511.12342332898515, 511.58050398673475, 523.3301374240901, 2930.457865294927, 3113.9377212455624, 3222.307203951115, 3318.0377690469495, 3410.4031794435873, 55592.72203638956, 57328.14007789887, 57353.42646573481, 58118.0, 58339.0, 50144.49855501471, 50705.0, 50710.74644626827, 50782.0, 50978.23532647013, 37807.43288850669, 42959.78520107379, 43133.568664313585, 43478.0, 43604.781976089915, 6794.456443484411, 6858.074159988338, 6932.0, 7051.048108505286, 7196.568205907663, 34099.829500852335, 34120.317593648484, 34344.14139646529, 34522.30955380928, 34720.131996700286, 40694.0, 42115.368269475366, 43816.78091609649, 44323.0, 44635.77682111569, 6744.325567443217, 6770.5599136056, 6777.966110169417, 6845.315468453115, 6937.7571784987285, 9936.75158121024, 10026.097651211427, 10098.192144628265, 10149.137323327599, 10215.284930055122, 9176.6788162414, 9358.0, 9472.100150485692, 9708.708738737849, 9877.111060004634, 9632.614695412105, 9686.612535498783, 9712.951435242778, 9795.951020244853, 10319.226058045526, 8661.956690216508, 8719.476831390137, 8960.1935825776, 9025.0, 9317.487538185194, 8368.748937531884, 8515.233628973423, 8553.101924297858, 8663.653453861774, 8797.736067917973, 7761.61191940412, 8259.83480330378, 8325.666973321, 8414.789630259047, 8472.449290796325]}, "summary": {"suite": 6106.56813120876, "subtests": {"jquery.html": {"filtered": 6478.629839047901, "value": 6478.629839047901}, "dojo.html": {"filtered": 5008.510057232989, "value": 5008.510057232989}, "mootools.html": {"filtered": 3720.8744350034763, "value": 3720.8744350034763}, "ext.html": {"filtered": 17590.283563613797, "value": 17590.283563613797}, "prototype.html": {"filtered": 4409.923846422732, "value": 4409.923846422732}, "yui.html": {"filtered": 5536.014565976024, "value": 5536.014565976024}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447085739, "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": "20151109055233", "branch": "Mozilla-Aurora", "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7"}}, {"talos_counters": {}, "results": {"audio-dft": [172.0, 181.0, 180.0, 174.0, 175.0, 174.0, 181.0, 182.0, 176.0, 175.0], "ai-astar": [115.0, 107.0, 108.0, 112.0, 114.0, 111.0, 117.0, 114.0, 115.0, 109.0], "imaging-gaussian-blur": [137.0, 137.0, 124.0, 135.0, 135.0, 135.0, 130.0, 135.0, 136.0, 136.0], "audio-beat-detection": [155.0, 139.0, 169.0, 168.0, 143.0, 168.0, 140.0, 177.0, 166.0, 140.0], "json-stringify-tinderbox": [65.0, 69.0, 71.0, 74.0, 73.0, 74.0, 74.0, 75.0, 75.0, 72.0], "stanford-crypto-pbkdf2": [152.0, 164.0, 160.0, 162.0, 161.0, 162.0, 162.0, 153.0, 159.0, 162.0], "json-parse-financial": [58.0, 63.0, 65.0, 66.0, 66.0, 70.0, 69.0, 78.0, 63.0, 65.0], "stanford-crypto-sha256-iterative": [70.0, 74.0, 74.0, 77.0, 77.0, 78.0, 77.0, 78.0, 76.0, 77.0], "audio-fft": [81.0, 85.0, 89.0, 135.0, 74.0, 77.0, 79.0, 80.0, 130.0, 72.0], "imaging-darkroom": [134.0, 140.0, 140.0, 140.0, 139.0, 134.0, 140.0, 140.0, 141.0, 138.0], "stanford-crypto-ccm": [128.0, 140.0, 137.0, 138.0, 135.0, 133.0, 130.0, 140.0, 142.0, 141.0], "audio-oscillator": [104.0, 102.0, 153.0, 99.0, 100.0, 99.0, 144.0, 99.0, 97.0, 141.0], "stanford-crypto-aes": [86.0, 91.0, 93.0, 98.0, 91.0, 95.0, 91.0, 92.0, 93.0, 97.0], "imaging-desaturate": [113.0, 112.0, 114.0, 113.0, 112.0, 114.0, 114.0, 112.0, 111.0, 110.0]}, "summary": {"suite": 1637.9, "subtests": {"audio-fft": {"filtered": 90.2, "value": 90.2}, "stanford-crypto-pbkdf2": {"filtered": 159.7, "value": 159.7}, "audio-beat-detection": {"filtered": 156.5, "value": 156.5}, "stanford-crypto-ccm": {"filtered": 136.4, "value": 136.4}, "imaging-darkroom": {"filtered": 138.6, "value": 138.6}, "json-parse-financial": {"filtered": 66.3, "value": 66.3}, "audio-oscillator": {"filtered": 113.8, "value": 113.8}, "ai-astar": {"filtered": 112.2, "value": 112.2}, "audio-dft": {"filtered": 177.0, "value": 177.0}, "stanford-crypto-sha256-iterative": {"filtered": 75.8, "value": 75.8}, "json-stringify-tinderbox": {"filtered": 72.2, "value": 72.2}, "imaging-gaussian-blur": {"filtered": 134.0, "value": 134.0}, "stanford-crypto-aes": {"filtered": 92.7, "value": 92.7}, "imaging-desaturate": {"filtered": 112.5, "value": 112.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447085739, "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": "20151109055233", "branch": "Mozilla-Aurora", "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7"}}, {"talos_counters": {}, "results": {"DeltaBlue": [209.07380305247753], "Encrypt": [352.7336860670194], "NavierStokes": [6327.044025157233], "Decrypt": [6329.113924050633], "Splay": [678.42605156038], "Richards": [173.94329448599757], "RegExp": [32306.451612903227], "Earley": [783.2550860719875], "Boyer": [13849.315068493152], "RayTrace": [1116.0714285714287]}, "summary": {"suite": 18468.45755717921, "subtests": {"DeltaBlue": {"filtered": 316.2423940000001, "value": 316.2423940000001}, "Encrypt": {"filtered": 754.6231350000002, "value": 754.6231350000002}, "NavierStokes": {"filtered": 234.54870775347914, "value": 234.54870775347914}, "Decrypt": {"filtered": 42.05659800000001, "value": 42.05659800000001}, "Splay": {"filtered": 120.11773399999996, "value": 120.11773399999996}, "RegExp": {"filtered": 28.198237643534707, "value": 28.198237643534707}, "Richards": {"filtered": 202.95119799999992, "value": 202.95119799999992}, "Earley": {"filtered": 850.8888251748249, "value": 850.8888251748249}, "Boyer": {"filtered": 48.12245202769537, "value": 48.12245202769537}, "RayTrace": {"filtered": 663.0301440000001, "value": 663.0301440000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0080"}, "testrun": {"date": 1447085739, "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": "20151109055233", "branch": "Mozilla-Aurora", "revision": "cafe4b776cac0e837a746ee638c2cbbe4b89dcc7"}}] 08:35:52 INFO - RETURN: dromaeo_css: 6106.56 08:35:52 INFO - RETURN: kraken: 1637.90 08:35:52 INFO - RETURN: v8_7: 18468.46 08:35:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18468.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1637.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6106.56"}}} 08:35:52 INFO - Return code: 0 08:35:52 INFO - # TBPL SUCCESS # 08:35:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:52 INFO - 2015-11-09 08:35:52.139 screenresolution[1962:14978] starting screenresolution argv=screenresolution get 08:35:52 INFO - 2015-11-09 08:35:52.142 screenresolution[1962:14978] Display 0: 1600x1200x32@60 08:35:52 INFO - 2015-11-09 08:35:52.148 screenresolution[1963:14981] starting screenresolution argv=screenresolution list 08:35:52 INFO - Available Modes on Display 0 08:35:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:52 INFO - Intel HD Graphics 3000: 08:35:52 INFO - Chipset Model: Intel HD Graphics 3000 08:35:52 INFO - Type: GPU 08:35:52 INFO - Bus: Built-In 08:35:52 INFO - VRAM (Total): 512 MB 08:35:52 INFO - VRAM (Dynamic, Max): 10 08:35:52 INFO - Vendor: Intel (0x8086) 08:35:52 INFO - Device ID: 0x0116 08:35:52 INFO - Revision ID: 0x0009 08:35:52 INFO - Displays: 08:35:52 INFO - Display: 08:35:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:52 INFO - Display Serial Number: 1600x1200 60 08:35:52 INFO - Main Display: Yes 08:35:52 INFO - Mirror: Off 08:35:52 INFO - Online: Yes 08:35:52 INFO - Rotation: Supported 08:35:52 INFO - Return code: 0 08:35:52 INFO - Running post-action listener: _resource_record_post_action 08:35:52 INFO - Running post-run listener: _resource_record_post_run 08:35:53 INFO - Total resource usage - Wall time: 1253s; CPU: 30.0%; Read bytes: 446464; Write bytes: 686972928; Read time: 900; Write time: 50741 08:35:53 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 341391872; Write bytes: 344020992; Read time: 34863; Write time: 9108 08:35:53 INFO - run-tests - Wall time: 1214s; CPU: 30.0%; Read bytes: 401408; Write bytes: 341686272; Read time: 863; Write time: 41620 08:35:53 INFO - Running post-run listener: _upload_blobber_files 08:35:53 INFO - Blob upload gear active. 08:35:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:35:53 INFO - Copying logs to upload dir... 08:35:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1304.825494 ========= master_lag: 126.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 51 secs) (at 2015-11-09 08:38:00.279442) ========= ========= Started set props: build_url (results: 0, elapsed: 19 secs) (at 2015-11-09 08:38:00.283152) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010644 build_url: 'https://queue.taskcluster.net/v1/task/nqR-yertQM-6oluP3M94vw/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 19.18 ========= ========= Finished set props: build_url (results: 0, elapsed: 19 secs) (at 2015-11-09 08:38:19.468937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 24 secs) (at 2015-11-09 08:38:19.469222) ========= 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.EasTp0nVtK/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.fFraSSP2yx/Listeners TMPDIR=/var/folders/8q/nbst1k5s6014308r6jw03hrc00000w/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.005778 ========= master_lag: 24.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 24 secs) (at 2015-11-09 08:38:43.615725) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2015-11-09 08:38:43.616034) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2015-11-09 08:38:45.244733) ========= ========= Total master_lag: 176.92 =========