builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0067 starttime: 1446642335.45 results: success (0) buildid: 20151104030036 builduid: 1d23f3147b7e4652a5d0c41cda032e5a revision: 6077f51254c69a1e14e1b61acba4af451bf1783e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:35.452337) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:35.452933) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:35.453226) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.006084 basedir: '/builds/slave/test' ========= master_lag: 0.40 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:35.857132) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:35.857441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.391039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.391284) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.017335 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.442124) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.442413) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.442799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.443074) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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-04 05:05:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 827M=0s 2015-11-04 05:05:36 (827 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202925 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:05:36.754372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 mins, 31 secs) (at 2015-11-04 05:05:36.754665) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.310627 ========= master_lag: 91.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 mins, 31 secs) (at 2015-11-04 05:07:08.307069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 15 secs) (at 2015-11-04 05:07:08.307380) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6077f51254c69a1e14e1b61acba4af451bf1783e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6077f51254c69a1e14e1b61acba4af451bf1783e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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-04 05:07:09,016 truncating revision to first 12 chars 2015-11-04 05:07:09,016 Setting DEBUG logging. 2015-11-04 05:07:09,016 attempt 1/10 2015-11-04 05:07:09,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6077f51254c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-04 05:07:09,394 unpacking tar archive at: mozilla-central-6077f51254c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.930669 ========= master_lag: 15.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 15 secs) (at 2015-11-04 05:07:24.259548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2015-11-04 05:07:24.259865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2015-11-04 05:07:50.208995) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 05:07:50.209240) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 05:07:50.209602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2015-11-04 05:07:50.209883) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:07:50 INFO - MultiFileLogger online at 20151104 05:07:50 in /builds/slave/test 05:07:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:07:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:50 INFO - {'append_to_log': False, 05:07:50 INFO - 'base_work_dir': '/builds/slave/test', 05:07:50 INFO - 'blob_upload_branch': 'Firefox', 05:07:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:50 INFO - 'branch': 'Firefox', 05:07:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:50 INFO - 'config_files': ('talos/mac_config.py',), 05:07:50 INFO - 'default_actions': ('clobber', 05:07:50 INFO - 'read-buildbot-config', 05:07:50 INFO - 'download-and-extract', 05:07:50 INFO - 'populate-webroot', 05:07:50 INFO - 'create-virtualenv', 05:07:50 INFO - 'install', 05:07:50 INFO - 'run-tests'), 05:07:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:50 INFO - 'download_minidump_stackwalk': True, 05:07:50 INFO - 'download_symbols': 'ondemand', 05:07:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:50 INFO - 'installer_path': 'installer.exe', 05:07:50 INFO - 'log_level': 'info', 05:07:50 INFO - 'log_name': 'talos', 05:07:50 INFO - 'log_to_console': True, 05:07:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:50 INFO - 'opt_config_files': (), 05:07:50 INFO - 'pip_index': False, 05:07:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:50 INFO - 'cmd': ('bash', 05:07:50 INFO - '-c', 05:07:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:50 INFO - 'enabled': True, 05:07:50 INFO - 'halt_on_failure': False, 05:07:50 INFO - 'name': 'check_screen_resolution'},), 05:07:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:50 INFO - 'cmd': ('bash', 05:07:50 INFO - '-c', 05:07:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:50 INFO - 'enabled': True, 05:07:50 INFO - 'halt_on_failure': False, 05:07:50 INFO - 'name': 'check_screen_resolution'},), 05:07:50 INFO - 'run_cmd_checks_enabled': True, 05:07:50 INFO - 'sps_profile': False, 05:07:50 INFO - 'sps_profile_interval': 0, 05:07:50 INFO - 'suite': 'dromaeojs-e10s', 05:07:50 INFO - 'system_bits': '64', 05:07:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:50 INFO - 'title': 't-yosemite-r5-0067', 05:07:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:50 INFO - 'use_talos_json': True, 05:07:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:50 INFO - 'work_dir': 'build'} 05:07:50 INFO - ##### 05:07:50 INFO - ##### Running clobber step. 05:07:50 INFO - ##### 05:07:50 INFO - Running pre-action listener: _resource_record_pre_action 05:07:50 INFO - Running main action method: clobber 05:07:50 INFO - rmtree: /builds/slave/test/build 05:07:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:54 INFO - Running post-action listener: _resource_record_post_action 05:07:54 INFO - ##### 05:07:54 INFO - ##### Running read-buildbot-config step. 05:07:54 INFO - ##### 05:07:54 INFO - Running pre-action listener: _resource_record_pre_action 05:07:54 INFO - Running main action method: read_buildbot_config 05:07:54 INFO - Using buildbot properties: 05:07:54 INFO - { 05:07:54 INFO - "properties": { 05:07:54 INFO - "buildnumber": 2, 05:07:54 INFO - "product": "firefox", 05:07:54 INFO - "script_repo_revision": "production", 05:07:54 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:07:54 INFO - "repository": "", 05:07:54 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:07:54 INFO - "buildid": "20151104030036", 05:07:54 INFO - "slavename": "t-yosemite-r5-0067", 05:07:54 INFO - "pgo_build": "False", 05:07:54 INFO - "basedir": "/builds/slave/test", 05:07:54 INFO - "project": "", 05:07:54 INFO - "platform": "yosemite", 05:07:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:07:54 INFO - "slavebuilddir": "test", 05:07:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:07:54 INFO - "branch": "mozilla-central", 05:07:54 INFO - "repo_path": "mozilla-central", 05:07:54 INFO - "stage_platform": "macosx64", 05:07:54 INFO - "builduid": "1d23f3147b7e4652a5d0c41cda032e5a", 05:07:54 INFO - "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e" 05:07:54 INFO - }, 05:07:54 INFO - "sourcestamp": { 05:07:54 INFO - "repository": "", 05:07:54 INFO - "hasPatch": false, 05:07:54 INFO - "project": "", 05:07:54 INFO - "branch": "mozilla-central-macosx64-talos", 05:07:54 INFO - "changes": [ 05:07:54 INFO - { 05:07:54 INFO - "category": null, 05:07:54 INFO - "files": [ 05:07:54 INFO - { 05:07:54 INFO - "url": null, 05:07:54 INFO - "name": "https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:07:54 INFO - } 05:07:54 INFO - ], 05:07:54 INFO - "repository": "", 05:07:54 INFO - "rev": "6077f51254c69a1e14e1b61acba4af451bf1783e", 05:07:54 INFO - "who": "cbook@mozilla.com", 05:07:54 INFO - "when": 1446641887, 05:07:54 INFO - "number": 6619525, 05:07:54 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 05:07:54 INFO - "project": "", 05:07:54 INFO - "at": "Wed 04 Nov 2015 04:58:07", 05:07:54 INFO - "branch": "mozilla-central-macosx64-talos", 05:07:54 INFO - "revlink": "", 05:07:54 INFO - "properties": [ 05:07:54 INFO - [ 05:07:54 INFO - "buildid", 05:07:54 INFO - "20151104030036", 05:07:54 INFO - "Change" 05:07:54 INFO - ], 05:07:54 INFO - [ 05:07:54 INFO - "builduid", 05:07:54 INFO - "1d23f3147b7e4652a5d0c41cda032e5a", 05:07:54 INFO - "Change" 05:07:54 INFO - ], 05:07:54 INFO - [ 05:07:54 INFO - "pgo_build", 05:07:54 INFO - "False", 05:07:54 INFO - "Change" 05:07:54 INFO - ] 05:07:54 INFO - ], 05:07:54 INFO - "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e" 05:07:54 INFO - } 05:07:54 INFO - ], 05:07:54 INFO - "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e" 05:07:54 INFO - } 05:07:54 INFO - } 05:07:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:07:54 INFO - Running post-action listener: _resource_record_post_action 05:07:54 INFO - ##### 05:07:54 INFO - ##### Running download-and-extract step. 05:07:54 INFO - ##### 05:07:54 INFO - Running pre-action listener: _resource_record_pre_action 05:07:54 INFO - Running main action method: download_and_extract 05:07:54 INFO - mkdir: /builds/slave/test/build/tests 05:07:54 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')]} 05:07:54 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/test_packages.json 05:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/test_packages.json 05:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:07:56 INFO - Downloaded 1149 bytes. 05:07:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:07:56 INFO - Using the following test package requirements: 05:07:56 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'jsshell-mac.zip'], 05:07:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:07:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:07:56 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:07:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:07:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:07:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:07:56 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:56 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')]} 05:07:56 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:59 INFO - Downloaded 17457270 bytes. 05:07:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:07:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:07:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:05 INFO - Return code: 0 05:08:05 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:05 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:07 INFO - Downloaded 17457270 bytes. 05:08:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:08:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:13 INFO - Return code: 0 05:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:13 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:08:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:08:15 INFO - Downloaded 11131307 bytes. 05:08:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:08:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:08:15 INFO - Return code: 0 05:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:15 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:08:23 INFO - Downloaded 108628816 bytes. 05:08:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:23 INFO - mkdir: /builds/slave/test/properties 05:08:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:23 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:23 INFO - Contents: 05:08:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:23 INFO - Running post-action listener: _resource_record_post_action 05:08:23 INFO - Running post-action listener: set_extra_try_arguments 05:08:23 INFO - ##### 05:08:23 INFO - ##### Running populate-webroot step. 05:08:23 INFO - ##### 05:08:23 INFO - Running pre-action listener: _resource_record_pre_action 05:08:23 INFO - Running main action method: populate_webroot 05:08:23 INFO - Guessing talos json url... 05:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:23 INFO - https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:08:23 INFO - Downloaded 99 bytes. 05:08:23 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:08:23 INFO - Contents: 05:08:23 INFO - 20151104030036 05:08:23 INFO - https://hg.mozilla.org/mozilla-central/rev/6077f51254c69a1e14e1b61acba4af451bf1783e 05:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:23 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/6077f51254/testing/talos/talos.json 05:08:23 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/6077f51254/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/6077f51254/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:08:25 INFO - Downloaded 4264 bytes. 05:08:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:08:25 INFO - '../fennec_ids.txt'], 05:08:25 INFO - 'tests': ['tcheck2']}, 05:08:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:25 INFO - '--tppagecycles', 05:08:25 INFO - '7'], 05:08:25 INFO - 'tests': ['tsvgm']}}, 05:08:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'tests': ['damp', 'tps']}, 05:08:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['damp', 'tps']}, 05:08:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:25 INFO - 'other': {'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'other_l64': {'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:25 INFO - 'ts_paint', 05:08:25 INFO - 'tpaint', 05:08:25 INFO - 'sessionrestore', 05:08:25 INFO - 'sessionrestore_no_auto_restore']}, 05:08:25 INFO - 'svgr': {'tests': ['tsvgx', 05:08:25 INFO - 'tsvgr_opacity', 05:08:25 INFO - 'tart', 05:08:25 INFO - 'tscrollx', 05:08:25 INFO - 'cart']}, 05:08:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['tsvgx', 05:08:25 INFO - 'tsvgr_opacity', 05:08:25 INFO - 'tart', 05:08:25 INFO - 'tscrollx', 05:08:25 INFO - 'cart']}, 05:08:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'tests': ['tp5o']}, 05:08:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'talos_options': ['--e10s'], 05:08:25 INFO - 'tests': ['tp5o']}, 05:08:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'talos_options': ['--xperf_path', 05:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:25 INFO - 'tests': ['tp5n']}, 05:08:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:25 INFO - 'talos_options': ['--e10s', 05:08:25 INFO - '--xperf_path', 05:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 05:08:25 INFO - 'C:/slave/talos-data/talos/xperf.config'], 05:08:25 INFO - 'tests': ['tp5n']}}, 05:08:25 INFO - 'talos.zip': {'path': '', 05:08:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:25 INFO - Running post-action listener: _resource_record_post_action 05:08:25 INFO - ##### 05:08:25 INFO - ##### Running create-virtualenv step. 05:08:25 INFO - ##### 05:08:25 INFO - Running pre-action listener: _resource_record_pre_action 05:08:25 INFO - Running main action method: create_virtualenv 05:08:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:25 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 05:08:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:25 INFO - Using real prefix '/tools/python27' 05:08:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:30 INFO - Installing pip.................done. 05:08:30 INFO - Return code: 0 05:08:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:30 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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08:30 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 05:08:30 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 05:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:30 INFO - 'HOME': '/Users/cltbld', 05:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:30 INFO - 'LOGNAME': 'cltbld', 05:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:30 INFO - 'MOZ_NO_REMOTE': '1', 05:08:30 INFO - 'NO_EM_RESTART': '1', 05:08:30 INFO - 'PAGER': '/bin/cat', 05:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:30 INFO - 'PWD': '/builds/slave/test', 05:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:30 INFO - 'SHELL': '/bin/bash', 05:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:30 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:30 INFO - 'USER': 'cltbld', 05:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:30 INFO - 'XPC_FLAGS': '0x0', 05:08:30 INFO - 'XPC_SERVICE_NAME': '0', 05:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:31 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 05:08:31 INFO - Cleaning up... 05:08:31 INFO - Return code: 0 05:08:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08:31 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 05:08:31 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 05:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:31 INFO - 'HOME': '/Users/cltbld', 05:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:31 INFO - 'LOGNAME': 'cltbld', 05:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:31 INFO - 'MOZ_NO_REMOTE': '1', 05:08:31 INFO - 'NO_EM_RESTART': '1', 05:08:31 INFO - 'PAGER': '/bin/cat', 05:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:31 INFO - 'PWD': '/builds/slave/test', 05:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:31 INFO - 'SHELL': '/bin/bash', 05:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:31 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:31 INFO - 'USER': 'cltbld', 05:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:31 INFO - 'XPC_FLAGS': '0x0', 05:08:31 INFO - 'XPC_SERVICE_NAME': '0', 05:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:31 INFO - Downloading/unpacking psutil>=0.7.1 05:08:31 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 05:08:31 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 05:08:31 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 05:08:31 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 05:08:31 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 05:08:31 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 05:08:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:08:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:34 INFO - Installing collected packages: psutil 05:08:34 INFO - Running setup.py install for psutil 05:08:34 INFO - building 'psutil._psutil_osx' extension 05:08:34 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 05:08:37 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 05:08:37 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 05:08:37 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 05:08:38 INFO - building 'psutil._psutil_posix' extension 05:08:38 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 05:08:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:38 INFO - ^ 05:08:38 INFO - 1 warning generated. 05:08:38 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 05:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:38 INFO - Successfully installed psutil 05:08:38 INFO - Cleaning up... 05:08:38 INFO - Return code: 0 05:08:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:38 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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08:38 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 05:08:38 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 05:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:38 INFO - 'HOME': '/Users/cltbld', 05:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:38 INFO - 'LOGNAME': 'cltbld', 05:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:38 INFO - 'MOZ_NO_REMOTE': '1', 05:08:38 INFO - 'NO_EM_RESTART': '1', 05:08:38 INFO - 'PAGER': '/bin/cat', 05:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:38 INFO - 'PWD': '/builds/slave/test', 05:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:38 INFO - 'SHELL': '/bin/bash', 05:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:38 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:38 INFO - 'USER': 'cltbld', 05:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:38 INFO - 'XPC_FLAGS': '0x0', 05:08:38 INFO - 'XPC_SERVICE_NAME': '0', 05:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:38 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 05:08:38 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 05:08:38 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 05:08:38 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 05:08:38 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 05:08:38 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 05:08:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:41 INFO - Installing collected packages: mozsystemmonitor 05:08:41 INFO - Running setup.py install for mozsystemmonitor 05:08:41 INFO - Successfully installed mozsystemmonitor 05:08:41 INFO - Cleaning up... 05:08:41 INFO - Return code: 0 05:08:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08:41 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 05:08:41 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 05:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:41 INFO - 'HOME': '/Users/cltbld', 05:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:41 INFO - 'LOGNAME': 'cltbld', 05:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:41 INFO - 'MOZ_NO_REMOTE': '1', 05:08:41 INFO - 'NO_EM_RESTART': '1', 05:08:41 INFO - 'PAGER': '/bin/cat', 05:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:41 INFO - 'PWD': '/builds/slave/test', 05:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:41 INFO - 'SHELL': '/bin/bash', 05:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:41 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:41 INFO - 'USER': 'cltbld', 05:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:41 INFO - 'XPC_FLAGS': '0x0', 05:08:41 INFO - 'XPC_SERVICE_NAME': '0', 05:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:46 INFO - Downloading docopt-0.6.1.tar.gz 05:08:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:08:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:46 INFO - Running setup.py install for blobuploader 05:08:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:46 INFO - Running setup.py install for requests 05:08:47 INFO - Running setup.py install for docopt 05:08:47 INFO - Successfully installed blobuploader requests docopt 05:08:47 INFO - Cleaning up... 05:08:47 INFO - Return code: 0 05:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:47 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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08:47 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 05:08:47 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 05:08:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:47 INFO - 'HOME': '/Users/cltbld', 05:08:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:47 INFO - 'LOGNAME': 'cltbld', 05:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:47 INFO - 'MOZ_NO_REMOTE': '1', 05:08:47 INFO - 'NO_EM_RESTART': '1', 05:08:47 INFO - 'PAGER': '/bin/cat', 05:08:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:47 INFO - 'PWD': '/builds/slave/test', 05:08:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:47 INFO - 'SHELL': '/bin/bash', 05:08:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:47 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:47 INFO - 'USER': 'cltbld', 05:08:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:47 INFO - 'XPC_FLAGS': '0x0', 05:08:47 INFO - 'XPC_SERVICE_NAME': '0', 05:08:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:47 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-Rm9eDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:47 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-94rYKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-_4ctZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-J8GEu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-iKGM41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-q_KjfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-plBO_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-9UHo73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:48 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-Cn9dZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-OHXPN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-uJ9zJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-CG9snl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-rokgws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-nmrdp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-zNsTQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-ygpccq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:49 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-kC_gh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:50 INFO - Running setup.py install for manifestparser 05:08:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozcrash 05:08:50 INFO - Running setup.py install for mozdebug 05:08:50 INFO - Running setup.py install for mozdevice 05:08:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:50 INFO - Running setup.py install for mozfile 05:08:51 INFO - Running setup.py install for mozhttpd 05:08:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozinfo 05:08:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozInstall 05:08:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:51 INFO - Running setup.py install for mozleak 05:08:51 INFO - Running setup.py install for mozlog 05:08:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for moznetwork 05:08:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozprocess 05:08:52 INFO - Running setup.py install for mozprofile 05:08:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozrunner 05:08:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozscreenshot 05:08:53 INFO - Running setup.py install for moztest 05:08:53 INFO - Running setup.py install for mozversion 05:08:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:53 INFO - Cleaning up... 05:08:53 INFO - Return code: 0 05:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08: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 05:08: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 05:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:53 INFO - 'HOME': '/Users/cltbld', 05:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:53 INFO - 'LOGNAME': 'cltbld', 05:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:53 INFO - 'MOZ_NO_REMOTE': '1', 05:08:53 INFO - 'NO_EM_RESTART': '1', 05:08:53 INFO - 'PAGER': '/bin/cat', 05:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:53 INFO - 'PWD': '/builds/slave/test', 05:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:53 INFO - 'SHELL': '/bin/bash', 05:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:53 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:53 INFO - 'USER': 'cltbld', 05:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:53 INFO - 'XPC_FLAGS': '0x0', 05:08:53 INFO - 'XPC_SERVICE_NAME': '0', 05:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:53 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-swVsx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08: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)) 05:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:53 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-x8ZJKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08: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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-Q1PIKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08: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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-h2PtVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-6nxhx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08: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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-jmXimb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08: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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-5ebmTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-PmJZhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08: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)) 05:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:54 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-jFSiON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:55 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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-OTEVbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-cZc4FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-BG5lzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-wMYZVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-0nBFRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-V45AGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08: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)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:55 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-FJhtgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:56 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)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:56 INFO - Running setup.py (path:/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/pip-lfrAEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08: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)) 05:08: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)) 05:08: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)) 05:08: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)) 05:08: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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08: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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:58 INFO - Downloading blessings-1.5.1.tar.gz 05:08: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 05:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:59 INFO - Installing collected packages: blessings 05:08:59 INFO - Running setup.py install for blessings 05:08:59 INFO - Successfully installed blessings 05:08:59 INFO - Cleaning up... 05:08:59 INFO - Return code: 0 05:08:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:59 INFO - Reading from file tmpfile_stdout 05:08:59 INFO - Current package versions: 05:08:59 INFO - blessings == 1.5.1 05:08:59 INFO - blobuploader == 1.2.4 05:08:59 INFO - docopt == 0.6.1 05:08:59 INFO - manifestparser == 1.1 05:08:59 INFO - mozInstall == 1.12 05:08:59 INFO - mozcrash == 0.16 05:08:59 INFO - mozdebug == 0.1 05:08:59 INFO - mozdevice == 0.47 05:08:59 INFO - mozfile == 1.2 05:08:59 INFO - mozhttpd == 0.7 05:08:59 INFO - mozinfo == 0.9 05:08:59 INFO - mozleak == 0.1 05:08:59 INFO - mozlog == 3.0 05:08:59 INFO - moznetwork == 0.27 05:08:59 INFO - mozprocess == 0.22 05:08:59 INFO - mozprofile == 0.27 05:08:59 INFO - mozrunner == 6.11 05:08:59 INFO - mozscreenshot == 0.1 05:08:59 INFO - mozsystemmonitor == 0.0 05:08:59 INFO - moztest == 0.7 05:08:59 INFO - mozversion == 1.4 05:08:59 INFO - psutil == 3.1.1 05:08:59 INFO - requests == 1.2.3 05:08:59 INFO - wsgiref == 0.1.2 05:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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 0x100ce9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d56228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6206198e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, '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.0rOzhtvxUw/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.He98ks2pUq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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 05:08: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 05:08: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 05:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:59 INFO - 'HOME': '/Users/cltbld', 05:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:59 INFO - 'LOGNAME': 'cltbld', 05:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:59 INFO - 'MOZ_NO_REMOTE': '1', 05:08:59 INFO - 'NO_EM_RESTART': '1', 05:08:59 INFO - 'PAGER': '/bin/cat', 05:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:59 INFO - 'PWD': '/builds/slave/test', 05:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:59 INFO - 'SHELL': '/bin/bash', 05:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:08:59 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:59 INFO - 'USER': 'cltbld', 05:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:59 INFO - 'XPC_FLAGS': '0x0', 05:08:59 INFO - 'XPC_SERVICE_NAME': '0', 05:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 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)) 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Running post-action listener: _resource_record_post_action 05:09:00 INFO - Running post-action listener: _start_resource_monitoring 05:09:00 INFO - Starting resource monitoring. 05:09:00 INFO - ##### 05:09:00 INFO - ##### Running install step. 05:09:00 INFO - ##### 05:09:00 INFO - Running pre-action listener: _resource_record_pre_action 05:09:00 INFO - Running main action method: install 05:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:00 INFO - Reading from file tmpfile_stdout 05:09:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:00 INFO - Reading from file tmpfile_stdout 05:09:00 INFO - Output received: 05:09:00 INFO - Usage: mozinstall [options] installer 05:09:00 INFO - Options: 05:09:00 INFO - -h, --help show this help message and exit 05:09:00 INFO - -d DEST, --destination=DEST 05:09:00 INFO - Directory to install application into. [default: 05:09:00 INFO - "/builds/slave/test"] 05:09:00 INFO - --app=APP Application being installed. [default: firefox] 05:09:00 INFO - mkdir: /builds/slave/test/build/application 05:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:43 INFO - Reading from file tmpfile_stdout 05:09:43 INFO - Output received: 05:09:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:43 INFO - Running post-action listener: _resource_record_post_action 05:09:43 INFO - ##### 05:09:43 INFO - ##### Running run-tests step. 05:09:43 INFO - ##### 05:09:43 INFO - Running pre-action listener: _resource_record_pre_action 05:09:43 INFO - Running main action method: run_tests 05:09:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:43 INFO - 2015-11-04 05:09:43.046 screenresolution[1634:7951] starting screenresolution argv=screenresolution get 05:09:43 INFO - 2015-11-04 05:09:43.050 screenresolution[1634:7951] Display 0: 1600x1200x32@60 05:09:43 INFO - 2015-11-04 05:09:43.057 screenresolution[1635:7953] starting screenresolution argv=screenresolution list 05:09:43 INFO - Available Modes on Display 0 05:09:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:43 INFO - Intel HD Graphics 3000: 05:09:43 INFO - Chipset Model: Intel HD Graphics 3000 05:09:43 INFO - Type: GPU 05:09:43 INFO - Bus: Built-In 05:09:43 INFO - VRAM (Total): 512 MB 05:09:43 INFO - VRAM (Dynamic, Max): 10 05:09:43 INFO - Vendor: Intel (0x8086) 05:09:43 INFO - Device ID: 0x0116 05:09:43 INFO - Revision ID: 0x0009 05:09:43 INFO - Displays: 05:09:43 INFO - Display: 05:09:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:43 INFO - Display Serial Number: 1600x1200 60 05:09:43 INFO - Main Display: Yes 05:09:43 INFO - Mirror: Off 05:09:43 INFO - Online: Yes 05:09:43 INFO - Rotation: Supported 05:09:43 INFO - Return code: 0 05:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:43 INFO - Python 2.7.3 05:09:43 INFO - Return code: 0 05:09:43 INFO - grabbing minidump binary from tooltool 05:09: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')]} 05:09:43 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 0x100c9e9f0>, '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 0x1009fdcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c68990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:43 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 05:09:43 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 05:09:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:43 INFO - Return code: 0 05:09:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0067', '--webServer', 'localhost'] in /builds/slave/test/build 05:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0067 --webServer localhost 05:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0rOzhtvxUw/Render', 05:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:43 INFO - 'HOME': '/Users/cltbld', 05:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:43 INFO - 'LOGNAME': 'cltbld', 05:09:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:43 INFO - 'MOZ_NO_REMOTE': '1', 05:09:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:43 INFO - 'NO_EM_RESTART': '1', 05:09:43 INFO - 'PAGER': '/bin/cat', 05:09:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:43 INFO - 'PWD': '/builds/slave/test', 05:09:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:43 INFO - 'SHELL': '/bin/bash', 05:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.He98ks2pUq/Listeners', 05:09:43 INFO - 'TMPDIR': '/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/', 05:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:43 INFO - 'USER': 'cltbld', 05:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:43 INFO - 'XPC_FLAGS': '0x0', 05:09:43 INFO - 'XPC_SERVICE_NAME': '0', 05:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0067', '--webServer', 'localhost'] with output_timeout 3600 05:09:43 INFO - mozversion INFO | application_buildid: 20151104030036 05:09:43 INFO - mozversion INFO | application_changeset: 6077f51254c69a1e14e1b61acba4af451bf1783e 05:09:43 INFO - mozversion INFO | application_display_name: Nightly 05:09:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:43 INFO - mozversion INFO | application_name: Firefox 05:09:43 INFO - mozversion INFO | application_remotingname: firefox 05:09:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:09:43 INFO - mozversion INFO | application_vendor: Mozilla 05:09:43 INFO - mozversion INFO | application_version: 45.0a1 05:09:43 INFO - mozversion INFO | platform_buildid: 20151104030036 05:09:43 INFO - mozversion INFO | platform_changeset: 6077f51254c69a1e14e1b61acba4af451bf1783e 05:09:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:09:43 INFO - mozversion INFO | platform_version: 45.0a1 05:09:43 INFO - 2015-11-04 05:09:43,827 DEBUG : using testdate: 1446642583 05:09:43 INFO - 2015-11-04 05:09:43,828 DEBUG : actual date: 1446642583 05:09:43 INFO - 2015-11-04 05:09:43,838 INFO : starting webserver on 'localhost:49268' 05:09:43 INFO - 2015-11-04 05:09:43,839 INFO : Starting test suite t-yosemite-r5-0067.e 05:09:43 INFO - 2015-11-04 05:09:43,839 INFO : Starting test dromaeo_css 05:09:43 INFO - 2015-11-04 05:09:43,839 DEBUG : operating with platform_type : mac_ 05:09:43 INFO - 2015-11-04 05:09:43,840 INFO : Initialising browser for dromaeo_css test... 05:09:43 INFO - 2015-11-04 05:09:43,870 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpNAyt2_/profile http://localhost:49268/getInfo.html 05:09:47 INFO - 2015-11-04 05:09:47,727 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:47 INFO - 2015-11-04 05:09:47,727 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:47 INFO - 2015-11-04 05:09:47,727 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:09:47 INFO - 2015-11-04 05:09:47,727 DEBUG : BROWSER_OUTPUT: __metrics 05:09:48 INFO - 2015-11-04 05:09:48,440 INFO : Browser initialized. 05:09:48 INFO - 2015-11-04 05:09:48,441 INFO : Running cycle 1/1 for dromaeo_css test... 05:09:48 INFO - 2015-11-04 05:09:48,441 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpNAyt2_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:10:00 INFO - 2015-11-04 05:10:00,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 233246720 05:10:00 INFO - 2015-11-04 05:10:00,634 DEBUG : BROWSER_OUTPUT: 05:10:50 INFO - 2015-11-04 05:10:50,494 DEBUG : BROWSER_OUTPUT: 1446642650488 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] 05:13:00 INFO - 2015-11-04 05:13:00,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 05:13:02 INFO - 2015-11-04 05:13:02,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 257089536 05:13:02 INFO - 2015-11-04 05:13:02,080 DEBUG : BROWSER_OUTPUT: 05:16:04 INFO - 2015-11-04 05:16:04,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 05:16:04 INFO - 2015-11-04 05:16:04,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 263278592 05:16:04 INFO - 2015-11-04 05:16:04,835 DEBUG : BROWSER_OUTPUT: 05:19:06 INFO - 2015-11-04 05:19:06,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 05:19:07 INFO - 2015-11-04 05:19:07,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 266330112 05:19:07 INFO - 2015-11-04 05:19:07,152 DEBUG : BROWSER_OUTPUT: 05:22:08 INFO - 2015-11-04 05:22:08,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 05:22:09 INFO - 2015-11-04 05:22:09,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 270512128 05:22:09 INFO - 2015-11-04 05:22:09,559 DEBUG : BROWSER_OUTPUT: 05:25:12 INFO - 2015-11-04 05:25:12,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 05:25:12 INFO - 2015-11-04 05:25:12,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 276795392 05:25:12 INFO - 2015-11-04 05:25:12,816 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 05:28:15 INFO - 2015-11-04 05:28:15,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 281153536 05:28:15 INFO - 2015-11-04 05:28:15,470 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,470 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:15 INFO - 2015-11-04 05:28:15,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:15 INFO - 2015-11-04 05:28:15,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:15 INFO - 2015-11-04 05:28:15,470 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:15 INFO - 2015-11-04 05:28:15,471 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.2638061342823;2649.2317228003885;2651.2576478585993;2703.3511957130295;2715.1447294102354;4384.539623339548;4459.375687403766;4513.729176249427;4549.226631472649;4605.171069207541;4335.306350983843;4387.29803231483;4435.68950173488;4473.396091527643;4542.000759832839;4122.134351786129;4159.230542349667;4176.081262122329;4208.579142085798;4217.978910105445;489.66952145933107;4134.958650413502;4139.130782535671;4166.270902592049;4283.271843786548;4135.400366946806;4145.937810932838;4168.2080404723;4202.285611446062;4212.473440819897;4151.8546850860075;4188.267053265667;4192.559781222958;4214.431051808028;4253.957460425418;3954.3277642800795;4031.1937612477623;4067.6949228807957;4076.653484453825;4124.587541245882;4249.553796851348;4388.802503887333;4518.096380723836;4546.47715512717;4587.174308624446;4497.325401189815;4820.0841840050625;4829.1307564638355;4845.660803743739;4850.514948505156;4673.6027437667835;4828.927566086511;4876.585490233334;4889.168841296988;4955.430125535538;4496.100779844044;4534.297183936462;4544.931826022612;4557.065801510682;4577.107464044512;4758.833440829554;4863.610911127102;4927.507249275115;4928.137575924199;4931.556159945622;4676.415448068991;4693.460252070987;4761.928571071437;4779.30700048498;4825.010872771073;4780.1873681474235;4816.879578010507;4844.975775121173;4849.224124140121;4868.464468908417;4581.083783243364;4680.695754775997;4689.62483001359;4712.410948631421;4777.259524773665;4592.242280023758;4639.8144074237325;4661.370714953506;4783.378160839069;4788.521147885183;3799.2971300308977;3801.6198380162314;3803.847846086181;3816.3321418751607;3843.5387753469204;3314.5193946877566;3435.261418794971;3440.501127336572;3483.320752453247;3520.0319912024397;4444.088961762831;4460.843870464518;4495.078508905666;4522.5929666330185;4539.909201815945;4819.49395313494;4839.758012099381;4875.658703890765;4878.804847806119;4882.292067650171;4381.539938306496;4451.5103338632725;4511.977440112844;4539.341795439643;4548.431446069241;4231.174920890397;4277.786110694453;4287.721298115613;4302.913941721211;4344.761038142932;4823.348847905488;4887.926681099715;4895.902081958412;4936.43231028422;4951.950480495149;4746.406699162605;4775.021120670323;4872.731999740048;4873.853784386474;4881.072596206709;4873.561379475864;4881.73150476713;4883.8290659826735;4937.6716879717;4964.751762411937;4776.283557466408;4782.378290822171;4801.303810947463;4827.08285425768;4866.610671146371;4614.054118905683;4736.952630473651;4788.401449818773;4793.95206047949;4851.708897466164;4722.150012997693;4733.502982186821;4738.928916066193;4776.116418462457;4821.831235906727;4686.133065382915;4692.812287508598;4718;4744.596709279612;4759.16714574941;4401.075774087478;4508.098380324014;4522.0277640307495;4536.659750518658;4595.540445955377;4548.56788605082;4684.601808846286;4734.73958932262;4745.064685079883;4808.206645903387;4430.446194225722;4476.888077798081;4655.743934083523;4694.4366675997735;4723.527647235249 05:28:15 INFO - 2015-11-04 05:28:15,471 DEBUG : BROWSER_OUTPUT: |1;ext.html;450.3424999500727;465.85092770313514;469.4999825186176;473.8104758096762;493.4054464370434;30795.69204307956;31345.843270783615;31429.68570314296;31445.685543144562;31487.370252594963;35142.472862907074;35995.820020899926;36360.45459318112;36368;36473.90578282649;7649.311561959423;7726.420518461138;7872.409569282327;7877.527348359088;7893.447458677895;7461.552306861606;7643.273888980538;7654.234576542329;7665.041869766279;7675.692972281102;7584.165741768401;7679.616019199046;7681.7695469136015;7723.382129429632;7756.689732410697;7654.349380302653;7737.187595302468;7767.456278060538;7770.0287464067;7851.5681637509915;7437.590932498711;7585.051868516435;7639.885401718979;7655.272749088827;7666.118396384376;33586.496202556984;33713;33767.83116084428;33810.66189338124;33862.15344616404;2187.5406164705432;2288.6338185890177;2491.700995880488;2554;2668.3462551674966;22212.666809997863;22515.211967581057;22868.970896309707;23249.18627848034;23361.7663823363;1926.749522562072;2002.3092033248506;2009.7186393904865;2035.1960975414777;2044.8057434543693;203381.6618338169;203620;207209;207891;207926;41812.58187418148;42461.57538424638;48419.75790121097;48979.26531102036;48998.75500622474;50603.24095138576;50869.49130508648;51464;52100.478995210324;52227.73886130545;11886.108541859223;12060.396980150957;12078.21491603043;12093.093018023683;12159.696007599881;8743.431676940978;8974.371793974358;9008;9054.366194366463;9076.27389808827;15693.529194124194;15856.603584910239;15902.76145857813;15976;16005.199740012953;6791.660416979132;6902.102726645604;6954.687039083254;7002.509824312249;7043.964780176067;749.243264303047;760.9124950630637;784.8744200927824;825.7316372179066;886.2394436164928;23546;23581.528369432515;23597.410064748517;23631;23757.16849910245;891.4517571693361;911.7036962987056;915.4736026784492;973.3819024919086;1045.3518818332682;12257.877421225852;12345.876541234473;12357.25856448616;12470.127091103535;12472.189307694971;259387;259944;265885;266742;266884;45229.773851130536;45509.08981820411;45533.772331138134;45580;45731.77134114374;1138.7267055906523;1140.2417392434104;1143.519721716881;1149.9482523286472;1162.0877611075434;21800.127994880026;21884.45288867791;22253.443663908532;22378.21676241389;22461.213857514907;33381.83309083439;33884.32231355408;33905.83047084749;34043.14892127617;34153.829230853684;198449;198707;200123;200554;201574;25135.622965655897;26254.868725656248;26485.867570662023;26596.335091622863;26643.33391665224;32615.836920815244;32804.179895501846;41522;45365.319520207886;45395.773021136;28978.27554311159;33504.667995384574;33784;34038.65961340355;34049.65950340564;33326.833365833016;33439.83280083681;33473.49789753204;33676;33781;32946.34107317888;32948.1762955928;33650.83174584209;33969.49045764266;34286.314273713884;28498.430031399672;29858;29893.850530747208;30186.094417167522;30275.091747247618;21734.782652173275;21825.454363641034;21849.563008739417;22223;22273 05:28:15 INFO - 2015-11-04 05:28:15,474 DEBUG : BROWSER_OUTPUT: |2;jquery.html;274.5908596191675;275.14430122319584;279.9790015748818;281.6254381672376;282.6424572915262;11970.880291197085;14195.716085678294;14731.631709207275;14802.111873287611;15134;15049.548513544583;15138.697226055472;15428;15581.065136091815;15602.375904963816;4312.18068566972;4330.307150855863;4520.254158063915;4520.9095818083615;4530.048689775152;4415.646748260131;4445.53321901199;4454.265046267362;4467.994701192222;4509.7970591323465;3136.294333774894;3453.8100404477746;4397.230484665187;4416.425864637593;4848.054629347261;4841.588464980481;4843.39457567804;4867.269909513566;4900.6569540132205;4914.483979182188;4131.958680413188;4225.3239481683095;4225.767582782945;4231.809568569391;4278.743275403485;17770.644587108316;18124.90937545317;18146.818531814777;18155.636887262182;18448.53878653031;1730.6106126121647;1741.5733145379336;1790.355472030068;1808.52074200337;1839.291872629034;10823.458827058694;11275.210735248536;11389.601363952304;11458.083353331713;11575.47910344028;1341.966450838727;1365.6790654196257;1371.7942308653683;1378.6553361659585;1425.4013314407973;47601.76199119017;48492.75753621209;48834.26748598774;50019.74990125062;59506.40493595095;14059.859401405854;14283.78574321386;14297.356618952172;14879.10725356482;15031.924840375728;21066.78933210679;21149.68275475869;21354.89322553377;21356;21571.568568628853;7714.112877019103;7758.495697779626;7809.492382995087;7810.218978102258;7815.6482958267015;6431.228252609623;6489.123968264318;6504.707288172043;6509.381608747161;6533.379328963741;6765.594064356154;6923.6884340204815;6946.687399067054;6951.6871740771785;6977.441804655616;2686.8522231277075;2808.9297767555977;2863.6134121893692;2892.117904039288;2990.177701132206;339.9031276086353;341.46560632609885;343.2568489220809;344.8999790060854;354.83322838265974;8582.485050896841;8841.911580884109;9051.321150913576;9167.12912273333;9226.53867306632;339.8148009334918;346.9340825243196;355.77408345700667;360.27584555044024;367.65807798746886;4772.642051846056;4883.902321953541;4901.460839307744;5169.948300517022;5241.9213711794355;338228;344860;345811;346954;355567;57865.13202301969;59957;60948.08577871336;61275.69362153161;61622;361.4163126550602;369.79661186347937;373.8373807393792;376.3451594226027;378.78977167672207;8619.267362274277;8860.955695221483;9038.141376569216;9122.680706175252;9384.249260059316;28177.154685359474;28539.857300714193;28583.714162858105;28657;29420.558691619215;37459.250814983;38057;38145.42781858219;38310.80844595759;38362.80818595889;6359.491240700825;6384;6498.512611554247;6522.510811689048;6531.673416329069;9580.329376943548;9737.513124343614;9854.162396196403;9961.900380996098;9963.302568820112;7300.817479563053;7420.6289685516585;7492.7752167435065;7601.467897247139;7908.52548847071;7552.207018263003;7572.697092116254;7603.239676032353;7763.650635721293;8031.317338026333;7836.529808211526;8039.1156972734125;8111.351091912751;8127.268545830667;8181.79545511367;11772.76385979494;12422.130450868352;12423.254604723745;12821.166624169398;13245;12461.688457788629;12687.936560317139;12829.294388808705;12967.221966681653;13041.673958151123 05:28:15 INFO - 2015-11-04 05:28:15,476 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1382.460840272294;1431.9355628996689;1432.8352239492456;1447.1823419767834;1481.444458328127;5555.083411237141;5709.914351284724;6025.156478093065;6131.785387511438;6166.938330616693;5758.856028599287;5784.161296611988;5890.3226128995175;5892.734826932788;5898.262717160355;1659.7427398753211;1730.0484733396581;1732.558197659595;1750.1249375312343;1752.4830175098377;1801.5766294920684;1805.918733656982;1808.9457316280532;1820.1263393571094;1834.3304693786806;1743.6948534006563;1779.3594306049877;1782.1623836796684;1800.837924586787;1801.8198180182007;1752.0976697001054;1777.8933264004202;1780.7863056433246;1795.6767781799272;1801.3155001099499;1807.2319264312614;1808.4665023818006;1811.9637607247912;1827.4791684370023;1828.9817101828944;5940.495057920082;6002.069679199731;6062.181605483247;6068.393160683941;6076.088586711984;3643.1802844360072;3781.6029316921604;3789.412641040643;3792.8862134135743;3798.4682144499793;2009.7889721579315;2076.1384025629345;2301.9424514387106;2309.642005489152;2388.856668599872;730.6675462664475;754.2608243920988;754.3658179226211;766.8657984852629;771.1093686791764;7730.884036739453;7755.379569634472;7770.26182512666;7783.143854176036;7787.844243115106;3320.236345640516;3416.7095796857548;3432.502287168347;3454.360943225511;3495.598006229316;6728.360805723449;6771.424428923498;6832.5558838676325;6846.836037873573;6857.862842743217;3769.3968964965475;3777.206786574795;3793.6585707285926;3806.1245913440066;3812.72273788284;3397.9830100849335;3443.139215196201;3472.8610855565494;3481.912952176165;3506.0708912138302;2889.7977141599886;2912.1554749122943;2914.664813546427;2938.3682508260827;2945.602343683618;946.5503885654259;948.9288303377136;960.5629438605417;967.1585720423277;967.5210770668564;1045.2839804733783;1064.808334499782;1096.9122470202365;1112.6828853776635;1120.843081968525;5668.178114173422;5670.432956704379;5671.914921276184;5690.459406356389;5732.111522713986;386.1909300016461;390.29551659255316;394.2056755637393;394.8025987006497;399.93201155803;4588.472325682589;4593.425821772278;4595;4633.235516139866;4636.11913736389;6797.762078327334;6880.139982502187;6954.09596752429;6994.090768200102;7018.789436316919;6940.13248343957;6947.687354068978;6951.443884489228;6976.162860456778;7027.402670772939;5679.545636349082;5689.317281926195;5697.715114244271;5709.628874123168;5727.0550359190265;5498.642588231752;5618.129189975561;5631.042722737063;5648.096304591246;5677.914831277451;6192.380761923771;6273.059041143865;6280.214973128359;6322.557420980671;6333.271673757393;6373.362663733589;6409.455196308366;6421;6444.452221561032;6462.063000864754;5052.267421223975;5359.088954877758;5399.757010934596;5411.594130440154;5418.160185171305;5752.942470575241;5760.971195143998;5761.135829625589;5789.94210057894;5821.76712931478;5420.186971954238;5424.83725488236;5437.864053398696;5464.781408743605;5524.14375771756;5310.920336194883;5311.3891902431715;5336.439673834191;5350.6254562180275;5434.429384914685;5423;5438.945610544002;5468.070428027166;5476.835694929158;5483.150111732688;4977.8257760978195;4982.352294201731;4984.252362145562;4988.700677959334;4994.9500504994485;4521.502634710114;4753.5008824072975;5046.444891062054;5067.138586440387;5094.083065048327 05:28:15 INFO - 2015-11-04 05:28:15,480 DEBUG : BROWSER_OUTPUT: |4;prototype.html;260.8878182381576;262.8830170574095;263.03335242982047;265.0907387660325;267.86472831220243;5041.143005689032;5112.590992720583;5150.5107014833575;5159.251908473269;5161.561267292284;4950.702957822533;4984.476629953857;5113.156329205686;5117.974410127954;5127.359080114986;3895.7662540247675;3930.7838068906126;3945;3953.3081710700512;3982.6017398260233;3916.7454115482547;3935.5080614923136;3950;3955.940660890089;3956.5449973253158;3751.7936513491745;3907.941380879289;3908.9022774430723;3911.1395492991496;3926.0577461409343;3931.253061918226;3952.9604703953023;3955.9011024724323;3966.325724626806;3971.384435412516;3394.9660503395144;3412.4710669846213;3420.640832712554;3434.862605495777;3447.2933048725204;4979.576735977446;5026.070177017264;5051.0150520648485;5051.52010559;5081.517255860687;4459.44256967879;4464.397306363664;4478.484974227973;4494.550544945512;4510.864674059783;5202;5285;5384.865378365533;5417.079096553595;5460.180972854104;3686.6313368663186;3717.8326975286177;3729;3739.383001804699;3741.28915506053;5594.608377413582;5601.719914004324;5648.661080335152;5659.51894089003;5670.914936275959;3782.508273924372;3788.6969042476535;3797.8480860765812;3805.82873770681;3805.9429108563395;3717.1078941054493;3747.9437808432895;3793.430985352164;3891.377379619247;3914.0410599402758;4366.214081465367;4382.583654552813;4411.669124815651;4433.689641725048;4439.755813430293;5378.408375078739;5394.62237643369;5400.243965844785;5406.053940560386;5411.621186516906;1379.2620947792882;1382;1384.1625816381145;1384.4808196926153;1391.3947432866735;889.2574700125339;909.9954500227457;918.8713580098791;938.5823308627595;939.6382392778829;5179.689218646893;5220.138677118233;5234.136367499396;5261.316028916293;5283.498067683564;5624.578156638268;5653.378128405872;5655.236543066716;5687.971560142173;5717.62835415705;5143.537081662668;5208.401033881077;5210.21846722987;5221.869453263623;5235.921461178009;3038.9696103039128;3077.0614962436225;3122.9687703122677;3142.8742850285735;3159.526071089355;5688.203651488795;5692.31692196939;5730.512906402919;5732.254806875079;5733.197352370671;5695.5443564514735;5747.626404283708;5775.624584402084;5804.564657650693;5835.978703726831;5518.889622207614;5670.206171136044;5699.971500142473;5713.085906254979;5740.4213841194005;5471.097268950579;5584.664920104807;5619.522340601095;5633.521150702236;5680.68756218412;5481.232627432083;5526.364468086222;5535.972320138373;5548.778048878;5556.138798486241;5641.464060914206;5670.489655930986;5685.289338832646;5702.34423041339;5742.454466825645;3542.50404943303;3619.7647152934974;3822.6941844652915;3844.788536630512;3853.576106628325;5380.408155103014;5494.066008778437;5520.447955204608;5520.66875987442;5598.32820061579;5340.919886201632;5378.435264297349;5404.54061404785;5431.8098866539485;5452.345718513804;5311.9468805313;5352.892942141058;5353.330833645794;5356.384015838228;5424.484673955968;5235.554977826775;5240.868978275574;5242.266082748494;5282.445343238905;5283.788648454019;5283.709395983258;5428.077226871363;5432.592555558428;5440.727963601725;5464.590155738256;5308.920366194433;5334.653247538898;5348.064088784369;5354.303940487712;5379.65032272901 05:28:15 INFO - 2015-11-04 05:28:15,480 DEBUG : BROWSER_OUTPUT: |5;yui.html;537.4437457231763;568.3208565763914;611.9235095613049;630.2405601250493;631.4543836358845;11179.776404471906;11230.55077796887;11386.601468948567;11437.370944598044;11516.884831151696;9786;10763;10837.891621083787;10845.945770271137;10856.837147442775;751.346328694037;753.6796861333938;762.6339357108591;766.2069757800678;768.5235154204402;752.289086812962;754.0950858969231;761.980950476237;764.354120767953;766.0462723908713;789.135896193667;795.5862951265339;796.2634563029204;805.2350267246111;805.7179987004531;782.2451334462243;791.3629528229773;791.9643616037292;800.0279660212811;800.0958916424432;583.5885700581123;583.7519054401862;585.5198737035632;590.6160995353055;595.1192235491453;11201.495932682967;11224.158188135922;11265.774684506347;11331.15016373767;11335.093192544658;7511;7879.566623835687;7919.762407127795;9268.49023303718;10212.438315892623;7348.338649521515;7388;7507.887381689279;7526.548407095537;7673.155952845183;2462.6429167770752;2495.301315631626;2518.6977562692596;2586.935326616831;2627.658404407434;34417;34673.30653386918;34846.30307393863;34858.65141348579;35252.47121293183;5641.52047075995;5647.830565083054;5662.631928924607;5789;5818.389069147764;9629.807403852024;9682.9031709682;9707.70876873695;9715;9722.9027709722;5330.573554115662;5333.946660533345;5334.653247538898;5370.301860758154;5418.756155972991;3230.2570408806105;3245.221146924768;3245.626752923397;3284.244623736506;3307.7188438982475;2159.913603455844;2199.7030400895674;2212.590670725921;2217.4013016485783;2222.833287503444;330.51744453098746;331.1373871065887;368.4804425759666;385.3102945727173;386.9899562142805;390.6581740976645;473.1861198738165;487.54171079185454;497.4354108087347;522.7151202594595;6256.124142620037;6633.867322653617;6654.367835055758;6892.483063770237;6899.6205208713;389.9785511796878;415.02883253187684;415.93552999285157;438.2527790117841;477.3698717692682;2990.8055976361466;3082.7018975454707;3212.9678703213135;3221.8066915984646;3259.2014956335374;49479.25781113286;50074.49925500698;50719.74640126776;51063.489365106616;51181.48818511842;38520.80739596284;38585.614143858766;42237.57762422398;43210.78394608007;43374.13251734948;40136;40345.39481907774;40660.59339406627;40770.38844417336;40808.9999999994;6725.730970761115;6827.590344579341;6982.1272340957385;7038.753643622448;7117.537360071578;28137.57793633138;29184.124476265744;29441;29567.704322957357;29573.408531829675;36481;37518.06204844901;37589.4361584571;37924.05189870275;38221.4266786004;9118.680846170351;9159.908400916172;9165.450072995642;9166.17504424605;9275.6289748412;9001.594928228114;9164.175224229584;9484.336096473457;9597;9755.756106097404;8402.41183117176;8484.660613575636;8690.30477561781;8874.378793484395;9070.954645226731;8526.78683032929;8674.132586741276;8789.252913502423;9059.320550958573;9391.577379018097;8342.097786373466;8414.284785793276;8490.108538603605;8665.740027799176;9254.953725231331;7503.66233519482;7553.433492487976;7600.80997975055;7642.694292228249;7810.9218907812465;6579.342065793382;7486.737964171228;7664.73173438927;7667.424943129176;7942.483738556975 05:28:15 INFO - 2015-11-04 05:28:15,480 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:15 INFO - 2015-11-04 05:28:15,481 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:15 INFO - 2015-11-04 05:28:15,481 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 05:28:15 INFO - 2015-11-04 05:28:15,481 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:15 INFO - 2015-11-04 05:28:15,481 DEBUG : BROWSER_OUTPUT: __startTimestamp1446643695465__endTimestamp 05:28:15 INFO - 2015-11-04 05:28:15,481 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,482 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:15 INFO - 2015-11-04 05:28:15,482 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:28:15 INFO - 2015-11-04 05:28:15,482 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,482 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4453.98 Median:4592.24 stddev:561.57 (12.2%) stddev-sans-first:544.74 05:28:15 INFO - 2015-11-04 05:28:15,483 DEBUG : BROWSER_OUTPUT: Values: 2629.3 2649.2 2651.3 2703.4 2715.1 4384.5 4459.4 4513.7 4549.2 4605.2 4335.3 4387.3 4435.7 4473.4 4542.0 4122.1 4159.2 4176.1 4208.6 4218.0 489.7 4135.0 4139.1 4166.3 4283.3 4135.4 4145.9 4168.2 4202.3 4212.5 4151.9 4188.3 4192.6 4214.4 4254.0 3954.3 4031.2 4067.7 4076.7 4124.6 4249.6 4388.8 4518.1 4546.5 4587.2 4497.3 4820.1 4829.1 4845.7 4850.5 4673.6 4828.9 4876.6 4889.2 4955.4 4496.1 4534.3 4544.9 4557.1 4577.1 4758.8 4863.6 4927.5 4928.1 4931.6 4676.4 4693.5 4761.9 4779.3 4825.0 4780.2 4816.9 4845.0 4849.2 4868.5 4581.1 4680.7 4689.6 4712.4 4777.3 4592.2 4639.8 4661.4 4783.4 4788.5 3799.3 3801.6 3803.8 3816.3 3843.5 3314.5 3435.3 3440.5 3483.3 3520.0 4444.1 4460.8 4495.1 4522.6 4539.9 4819.5 4839.8 4875.7 4878.8 4882.3 4381.5 4451.5 4512.0 4539.3 4548.4 4231.2 4277.8 4287.7 4302.9 4344.8 4823.3 4887.9 4895.9 4936.4 4952.0 4746.4 4775.0 4872.7 4873.9 4881.1 4873.6 4881.7 4883.8 4937.7 4964.8 4776.3 4782.4 4801.3 4827.1 4866.6 4614.1 4737.0 4788.4 4794.0 4851.7 4722.2 4733.5 4738.9 4776.1 4821.8 4686.1 4692.8 4718.0 4744.6 4759.2 4401.1 4508.1 4522.0 4536.7 4595.5 4548.6 4684.6 4734.7 4745.1 4808.2 4430.4 4476.9 4655.7 4694.4 4723.5 05:28:15 INFO - 2015-11-04 05:28:15,484 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,484 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37120.31 Median:33545.58 stddev:58698.86 (175.0%) stddev-sans-first:58798.95 05:28:15 INFO - 2015-11-04 05:28:15,485 DEBUG : BROWSER_OUTPUT: Values: 450.3 465.9 469.5 473.8 493.4 30795.7 31345.8 31429.7 31445.7 31487.4 35142.5 35995.8 36360.5 36368.0 36473.9 7649.3 7726.4 7872.4 7877.5 7893.4 7461.6 7643.3 7654.2 7665.0 7675.7 7584.2 7679.6 7681.8 7723.4 7756.7 7654.3 7737.2 7767.5 7770.0 7851.6 7437.6 7585.1 7639.9 7655.3 7666.1 33586.5 33713.0 33767.8 33810.7 33862.2 2187.5 2288.6 2491.7 2554.0 2668.3 22212.7 22515.2 22869.0 23249.2 23361.8 1926.7 2002.3 2009.7 2035.2 2044.8 203381.7 203620.0 207209.0 207891.0 207926.0 41812.6 42461.6 48419.8 48979.3 48998.8 50603.2 50869.5 51464.0 52100.5 52227.7 11886.1 12060.4 12078.2 12093.1 12159.7 8743.4 8974.4 9008.0 9054.4 9076.3 15693.5 15856.6 15902.8 15976.0 16005.2 6791.7 6902.1 6954.7 7002.5 7044.0 749.2 760.9 784.9 825.7 886.2 23546.0 23581.5 23597.4 23631.0 23757.2 891.5 911.7 915.5 973.4 1045.4 12257.9 12345.9 12357.3 12470.1 12472.2 259387.0 259944.0 265885.0 266742.0 266884.0 45229.8 45509.1 45533.8 45580.0 45731.8 1138.7 1140.2 1143.5 1149.9 1162.1 21800.1 21884.5 22253.4 22378.2 22461.2 33381.8 33884.3 33905.8 34043.1 34153.8 198449.0 198707.0 200123.0 200554.0 201574.0 25135.6 26254.9 26485.9 26596.3 26643.3 32615.8 32804.2 41522.0 45365.3 45395.8 28978.3 33504.7 33784.0 34038.7 34049.7 33326.8 33439.8 33473.5 33676.0 33781.0 32946.3 32948.2 33650.8 33969.5 34286.3 28498.4 29858.0 29893.9 30186.1 30275.1 21734.8 21825.5 21849.6 22223.0 22273.0 05:28:15 INFO - 2015-11-04 05:28:15,485 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,486 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21041.82 Median:38336.81 stddev:56720.26 (148.0%) stddev-sans-first:56857.94 05:28:15 INFO - 2015-11-04 05:28:15,487 DEBUG : BROWSER_OUTPUT: Values: 274.6 275.1 280.0 281.6 282.6 11970.9 14195.7 14731.6 14802.1 15134.0 15049.5 15138.7 15428.0 15581.1 15602.4 4312.2 4330.3 4520.3 4520.9 4530.0 4415.6 4445.5 4454.3 4468.0 4509.8 3136.3 3453.8 4397.2 4416.4 4848.1 4841.6 4843.4 4867.3 4900.7 4914.5 4132.0 4225.3 4225.8 4231.8 4278.7 17770.6 18124.9 18146.8 18155.6 18448.5 1730.6 1741.6 1790.4 1808.5 1839.3 10823.5 11275.2 11389.6 11458.1 11575.5 1342.0 1365.7 1371.8 1378.7 1425.4 47601.8 48492.8 48834.3 50019.7 59506.4 14059.9 14283.8 14297.4 14879.1 15031.9 21066.8 21149.7 21354.9 21356.0 21571.6 7714.1 7758.5 7809.5 7810.2 7815.6 6431.2 6489.1 6504.7 6509.4 6533.4 6765.6 6923.7 6946.7 6951.7 6977.4 2686.9 2808.9 2863.6 2892.1 2990.2 339.9 341.5 343.3 344.9 354.8 8582.5 8841.9 9051.3 9167.1 9226.5 339.8 346.9 355.8 360.3 367.7 4772.6 4883.9 4901.5 5169.9 5241.9 338228.0 344860.0 345811.0 346954.0 355567.0 57865.1 59957.0 60948.1 61275.7 61622.0 361.4 369.8 373.8 376.3 378.8 8619.3 8861.0 9038.1 9122.7 9384.2 28177.2 28539.9 28583.7 28657.0 29420.6 37459.3 38057.0 38145.4 38310.8 38362.8 6359.5 6384.0 6498.5 6522.5 6531.7 9580.3 9737.5 9854.2 9961.9 9963.3 7300.8 7420.6 7492.8 7601.5 7908.5 7552.2 7572.7 7603.2 7763.7 8031.3 7836.5 8039.1 8111.4 8127.3 8181.8 11772.8 12422.1 12423.3 12821.2 13245.0 12461.7 12687.9 12829.3 12967.2 13041.7 05:28:15 INFO - 2015-11-04 05:28:15,487 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,487 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4193.03 Median:5379.42 stddev:2110.91 (39.2%) stddev-sans-first:2106.27 05:28:15 INFO - 2015-11-04 05:28:15,489 DEBUG : BROWSER_OUTPUT: Values: 1382.5 1431.9 1432.8 1447.2 1481.4 5555.1 5709.9 6025.2 6131.8 6166.9 5758.9 5784.2 5890.3 5892.7 5898.3 1659.7 1730.0 1732.6 1750.1 1752.5 1801.6 1805.9 1808.9 1820.1 1834.3 1743.7 1779.4 1782.2 1800.8 1801.8 1752.1 1777.9 1780.8 1795.7 1801.3 1807.2 1808.5 1812.0 1827.5 1829.0 5940.5 6002.1 6062.2 6068.4 6076.1 3643.2 3781.6 3789.4 3792.9 3798.5 2009.8 2076.1 2301.9 2309.6 2388.9 730.7 754.3 754.4 766.9 771.1 7730.9 7755.4 7770.3 7783.1 7787.8 3320.2 3416.7 3432.5 3454.4 3495.6 6728.4 6771.4 6832.6 6846.8 6857.9 3769.4 3777.2 3793.7 3806.1 3812.7 3398.0 3443.1 3472.9 3481.9 3506.1 2889.8 2912.2 2914.7 2938.4 2945.6 946.6 948.9 960.6 967.2 967.5 1045.3 1064.8 1096.9 1112.7 1120.8 5668.2 5670.4 5671.9 5690.5 5732.1 386.2 390.3 394.2 394.8 399.9 4588.5 4593.4 4595.0 4633.2 4636.1 6797.8 6880.1 6954.1 6994.1 7018.8 6940.1 6947.7 6951.4 6976.2 7027.4 5679.5 5689.3 5697.7 5709.6 5727.1 5498.6 5618.1 5631.0 5648.1 5677.9 6192.4 6273.1 6280.2 6322.6 6333.3 6373.4 6409.5 6421.0 6444.5 6462.1 5052.3 5359.1 5399.8 5411.6 5418.2 5752.9 5761.0 5761.1 5789.9 5821.8 5420.2 5424.8 5437.9 5464.8 5524.1 5310.9 5311.4 5336.4 5350.6 5434.4 5423.0 5438.9 5468.1 5476.8 5483.2 4977.8 4982.4 4984.3 4988.7 4995.0 4521.5 4753.5 5046.4 5067.1 5094.1 05:28:15 INFO - 2015-11-04 05:28:15,489 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,489 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4520.44 Median:5221.00 stddev:1359.09 (26.0%) stddev-sans-first:1324.76 05:28:15 INFO - 2015-11-04 05:28:15,489 DEBUG : BROWSER_OUTPUT: Values: 260.9 262.9 263.0 265.1 267.9 5041.1 5112.6 5150.5 5159.3 5161.6 4950.7 4984.5 5113.2 5118.0 5127.4 3895.8 3930.8 3945.0 3953.3 3982.6 3916.7 3935.5 3950.0 3955.9 3956.5 3751.8 3907.9 3908.9 3911.1 3926.1 3931.3 3953.0 3955.9 3966.3 3971.4 3395.0 3412.5 3420.6 3434.9 3447.3 4979.6 5026.1 5051.0 5051.5 5081.5 4459.4 4464.4 4478.5 4494.6 4510.9 5202.0 5285.0 5384.9 5417.1 5460.2 3686.6 3717.8 3729.0 3739.4 3741.3 5594.6 5601.7 5648.7 5659.5 5670.9 3782.5 3788.7 3797.8 3805.8 3805.9 3717.1 3747.9 3793.4 3891.4 3914.0 4366.2 4382.6 4411.7 4433.7 4439.8 5378.4 5394.6 5400.2 5406.1 5411.6 1379.3 1382.0 1384.2 1384.5 1391.4 889.3 910.0 918.9 938.6 939.6 5179.7 5220.1 5234.1 5261.3 5283.5 5624.6 5653.4 5655.2 5688.0 5717.6 5143.5 5208.4 5210.2 5221.9 5235.9 3039.0 3077.1 3123.0 3142.9 3159.5 5688.2 5692.3 5730.5 5732.3 5733.2 5695.5 5747.6 5775.6 5804.6 5836.0 5518.9 5670.2 5700.0 5713.1 5740.4 5471.1 5584.7 5619.5 5633.5 5680.7 5481.2 5526.4 5536.0 5548.8 5556.1 5641.5 5670.5 5685.3 5702.3 5742.5 3542.5 3619.8 3822.7 3844.8 3853.6 5380.4 5494.1 5520.4 5520.7 5598.3 5340.9 5378.4 5404.5 5431.8 5452.3 5311.9 5352.9 5353.3 5356.4 5424.5 5235.6 5240.9 5242.3 5282.4 5283.8 5283.7 5428.1 5432.6 5440.7 5464.6 5308.9 5334.7 5348.1 5354.3 5379.7 05:28:15 INFO - 2015-11-04 05:28:15,489 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-11-04 05:28:15,490 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10945.36 Median:5803.69 stddev:13324.35 (229.6%) stddev-sans-first:13338.81 05:28:15 INFO - 2015-11-04 05:28:15,492 DEBUG : BROWSER_OUTPUT: Values: 537.4 568.3 611.9 630.2 631.5 11179.8 11230.6 11386.6 11437.4 11516.9 9786.0 10763.0 10837.9 10845.9 10856.8 751.3 753.7 762.6 766.2 768.5 752.3 754.1 762.0 764.4 766.0 789.1 795.6 796.3 805.2 805.7 782.2 791.4 792.0 800.0 800.1 583.6 583.8 585.5 590.6 595.1 11201.5 11224.2 11265.8 11331.2 11335.1 7511.0 7879.6 7919.8 9268.5 10212.4 7348.3 7388.0 7507.9 7526.5 7673.2 2462.6 2495.3 2518.7 2586.9 2627.7 34417.0 34673.3 34846.3 34858.7 35252.5 5641.5 5647.8 5662.6 5789.0 5818.4 9629.8 9682.9 9707.7 9715.0 9722.9 5330.6 5333.9 5334.7 5370.3 5418.8 3230.3 3245.2 3245.6 3284.2 3307.7 2159.9 2199.7 2212.6 2217.4 2222.8 330.5 331.1 368.5 385.3 387.0 390.7 473.2 487.5 497.4 522.7 6256.1 6633.9 6654.4 6892.5 6899.6 390.0 415.0 415.9 438.3 477.4 2990.8 3082.7 3213.0 3221.8 3259.2 49479.3 50074.5 50719.7 51063.5 51181.5 38520.8 38585.6 42237.6 43210.8 43374.1 40136.0 40345.4 40660.6 40770.4 40809.0 6725.7 6827.6 6982.1 7038.8 7117.5 28137.6 29184.1 29441.0 29567.7 29573.4 36481.0 37518.1 37589.4 37924.1 38221.4 9118.7 9159.9 9165.5 9166.2 9275.6 9001.6 9164.2 9484.3 9597.0 9755.8 8402.4 8484.7 8690.3 8874.4 9071.0 8526.8 8674.1 8789.3 9059.3 9391.6 8342.1 8414.3 8490.1 8665.7 9255.0 7503.7 7553.4 7600.8 7642.7 7810.9 6579.3 7486.7 7664.7 7667.4 7942.5 05:28:15 INFO - 2015-11-04 05:28:15,492 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:15 INFO - 2015-11-04 05:28:15,492 DEBUG : BROWSER_OUTPUT: 05:28:16 INFO - 2015-11-04 05:28:16,214 INFO : Browser exited with error code: 0 05:28:16 INFO - 2015-11-04 05:28:16,249 INFO : Completed test dromaeo_css (00:18:32) 05:28:16 INFO - 2015-11-04 05:28:16,249 INFO : Starting test kraken 05:28:16 INFO - 2015-11-04 05:28:16,249 DEBUG : operating with platform_type : mac_ 05:28:16 INFO - 2015-11-04 05:28:16,249 INFO : Initialising browser for kraken test... 05:28:16 INFO - 2015-11-04 05:28:16,265 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpNEJunw/profile http://localhost:49268/getInfo.html 05:28:19 INFO - 2015-11-04 05:28:19,474 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:19 INFO - 2015-11-04 05:28:19,476 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:19 INFO - 2015-11-04 05:28:19,476 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:28:19 INFO - 2015-11-04 05:28:19,476 DEBUG : BROWSER_OUTPUT: __metrics 05:28:20 INFO - 2015-11-04 05:28:20,220 INFO : Browser initialized. 05:28:20 INFO - 2015-11-04 05:28:20,220 INFO : Running cycle 1/1 for kraken test... 05:28:20 INFO - 2015-11-04 05:28:20,220 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmpNEJunw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:32 INFO - 2015-11-04 05:28:32,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 233123840 05:28:32 INFO - 2015-11-04 05:28:32,361 DEBUG : BROWSER_OUTPUT: 05:28:35 INFO - 2015-11-04 05:28:35,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:35 INFO - 2015-11-04 05:28:35,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 252014592 05:28:35 INFO - 2015-11-04 05:28:35,906 DEBUG : BROWSER_OUTPUT: 05:28:38 INFO - 2015-11-04 05:28:38,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 05:28:39 INFO - 2015-11-04 05:28:39,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 259813376 05:28:39 INFO - 2015-11-04 05:28:39,571 DEBUG : BROWSER_OUTPUT: 05:28:42 INFO - 2015-11-04 05:28:42,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 05:28:43 INFO - 2015-11-04 05:28:43,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 259575808 05:28:43 INFO - 2015-11-04 05:28:43,502 DEBUG : BROWSER_OUTPUT: 05:28:45 INFO - 2015-11-04 05:28:45,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 05:28:46 INFO - 2015-11-04 05:28:46,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 259989504 05:28:46 INFO - 2015-11-04 05:28:46,301 DEBUG : BROWSER_OUTPUT: 05:28:48 INFO - 2015-11-04 05:28:48,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:49 INFO - 2015-11-04 05:28:49,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 260546560 05:28:49 INFO - 2015-11-04 05:28:49,283 DEBUG : BROWSER_OUTPUT: 05:28:52 INFO - 2015-11-04 05:28:52,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:53 INFO - 2015-11-04 05:28:53,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 260308992 05:28:53 INFO - 2015-11-04 05:28:53,413 DEBUG : BROWSER_OUTPUT: 05:28:57 INFO - 2015-11-04 05:28:57,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:57 INFO - 2015-11-04 05:28:57,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 258625536 05:28:57 INFO - 2015-11-04 05:28:57,656 DEBUG : BROWSER_OUTPUT: 05:29:01 INFO - 2015-11-04 05:29:01,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 05:29:01 INFO - 2015-11-04 05:29:01,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 259280896 05:29:01 INFO - 2015-11-04 05:29:01,685 DEBUG : BROWSER_OUTPUT: 05:29:03 INFO - 2015-11-04 05:29:03,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:04 INFO - 2015-11-04 05:29:04,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 258404352 05:29:04 INFO - 2015-11-04 05:29:04,021 DEBUG : BROWSER_OUTPUT: 05:29:06 INFO - 2015-11-04 05:29:06,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:06 INFO - 2015-11-04 05:29:06,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 260378624 05:29:06 INFO - 2015-11-04 05:29:06,691 DEBUG : BROWSER_OUTPUT: 05:29:09 INFO - 2015-11-04 05:29:09,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:09 INFO - 2015-11-04 05:29:09,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 260497408 05:29:09 INFO - 2015-11-04 05:29:09,670 DEBUG : BROWSER_OUTPUT: 05:29:12 INFO - 2015-11-04 05:29:12,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:13 INFO - 2015-11-04 05:29:13,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 260288512 05:29:13 INFO - 2015-11-04 05:29:13,307 DEBUG : BROWSER_OUTPUT: 05:29:16 INFO - 2015-11-04 05:29:16,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:16 INFO - 2015-11-04 05:29:16,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 260714496 05:29:16 INFO - 2015-11-04 05:29:16,912 DEBUG : BROWSER_OUTPUT: 05:29:18 INFO - 2015-11-04 05:29:18,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 05:29:19 INFO - 2015-11-04 05:29:19,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 260190208 05:29:19 INFO - 2015-11-04 05:29:19,104 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,104 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:19 INFO - 2015-11-04 05:29:19,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: |0;ai-astar;133;124;141;139;141;145;134;134;135;141 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;181;173;192;202;163;185;186;164;204;155 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: |2;audio-dft;198;217;208;210;203;203;203;201;205;211 05:29:19 INFO - 2015-11-04 05:29:19,105 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;89;97;148;83;88;89;91;119;82 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;109;149;112;111;108;146;109;110;153 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;142;158;155;144;150;149;155;150;145 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;164;163;156;156;157;163;165;156;158 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;134;140;137;135;134;134;134;137;133;134 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;74;75;74;74;80;85;77;78 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;82;83;82;85;87;87;88;86;83 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;105;107;114;110;112;112;111;114;107;110 05:29:19 INFO - 2015-11-04 05:29:19,106 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;154;164;172;168;167;172;169;161;170;162 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;185;189;195;194;189;190;187;188;190;186 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;84;89;87;90;89;89;92;91;92 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,751 05:29:19 INFO - 2015-11-04 05:29:19,107 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:19 INFO - 2015-11-04 05:29:19,108 DEBUG : BROWSER_OUTPUT: __startTimestamp1446643759101__endTimestamp 05:29:19 INFO - 2015-11-04 05:29:19,108 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,108 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:19 INFO - 2015-11-04 05:29:19,108 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:29:19 INFO - 2015-11-04 05:29:19,108 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,109 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:136.70 Median:140.00 stddev:5.98 (4.3%) stddev-sans-first:6.19 05:29:19 INFO - 2015-11-04 05:29:19,109 DEBUG : BROWSER_OUTPUT: Values: 133.0 124.0 141.0 139.0 141.0 145.0 134.0 134.0 135.0 141.0 05:29:19 INFO - 2015-11-04 05:29:19,109 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,111 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:180.50 Median:185.50 stddev:16.61 (9.0%) stddev-sans-first:17.61 05:29:19 INFO - 2015-11-04 05:29:19,111 DEBUG : BROWSER_OUTPUT: Values: 181.0 173.0 192.0 202.0 163.0 185.0 186.0 164.0 204.0 155.0 05:29:19 INFO - 2015-11-04 05:29:19,111 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,111 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:205.90 Median:206.50 stddev:5.61 (2.7%) stddev-sans-first:5.17 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: Values: 198.0 217.0 208.0 210.0 203.0 203.0 203.0 201.0 205.0 211.0 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.50 Median:88.50 stddev:21.27 (24.0%) stddev-sans-first:21.60 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: Values: 79.0 89.0 97.0 148.0 83.0 88.0 89.0 91.0 119.0 82.0 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,112 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.10 Median:111.50 stddev:19.67 (17.6%) stddev-sans-first:19.86 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: Values: 104.0 109.0 149.0 112.0 111.0 108.0 146.0 109.0 110.0 153.0 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:149.10 Median:150.00 stddev:5.59 (3.7%) stddev-sans-first:5.47 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: Values: 143.0 142.0 158.0 155.0 144.0 150.0 149.0 155.0 150.0 145.0 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,113 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:159.40 Median:160.50 stddev:3.84 (2.4%) stddev-sans-first:3.87 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: Values: 156.0 164.0 163.0 156.0 156.0 157.0 163.0 165.0 156.0 158.0 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:135.20 Median:134.50 stddev:2.15 (1.6%) stddev-sans-first:2.24 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: Values: 134.0 140.0 137.0 135.0 134.0 134.0 134.0 137.0 133.0 134.0 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,114 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.70 Median:76.00 stddev:4.55 (6.0%) stddev-sans-first:4.33 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 74.0 75.0 74.0 74.0 80.0 85.0 77.0 78.0 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:84.10 Median:85.50 stddev:3.07 (3.6%) stddev-sans-first:2.33 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: Values: 78.0 82.0 83.0 82.0 85.0 87.0 87.0 88.0 86.0 83.0 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:110.20 Median:111.50 stddev:3.05 (2.7%) stddev-sans-first:2.59 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: Values: 105.0 107.0 114.0 110.0 112.0 112.0 111.0 114.0 107.0 110.0 05:29:19 INFO - 2015-11-04 05:29:19,115 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:165.90 Median:168.50 stddev:5.69 (3.4%) stddev-sans-first:4.09 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: Values: 154.0 164.0 172.0 168.0 167.0 172.0 169.0 161.0 170.0 162.0 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:189.50 stddev:3.20 (1.7%) stddev-sans-first:2.99 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: Values: 185.0 189.0 195.0 194.0 189.0 190.0 187.0 188.0 190.0 186.0 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.30 Median:89.50 stddev:3.77 (4.2%) stddev-sans-first:2.54 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 89.0 87.0 90.0 89.0 89.0 92.0 91.0 92.0 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:19 INFO - 2015-11-04 05:29:19,116 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-04 05:29:19,814 INFO : Browser exited with error code: 0 05:29:19 INFO - 2015-11-04 05:29:19,873 INFO : Completed test kraken (00:01:03) 05:29:19 INFO - 2015-11-04 05:29:19,873 INFO : Starting test v8_7 05:29:19 INFO - 2015-11-04 05:29:19,873 DEBUG : operating with platform_type : mac_ 05:29:19 INFO - 2015-11-04 05:29:19,873 INFO : Initialising browser for v8_7 test... 05:29:19 INFO - 2015-11-04 05:29:19,889 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmp42LVKQ/profile http://localhost:49268/getInfo.html 05:29:23 INFO - 2015-11-04 05:29:23,095 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:23 INFO - 2015-11-04 05:29:23,095 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:23 INFO - 2015-11-04 05:29:23,095 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:23 INFO - 2015-11-04 05:29:23,096 DEBUG : BROWSER_OUTPUT: __metrics 05:29:23 INFO - 2015-11-04 05:29:23,803 INFO : Browser initialized. 05:29:23 INFO - 2015-11-04 05:29:23,803 INFO : Running cycle 1/1 for v8_7 test... 05:29:23 INFO - 2015-11-04 05:29:23,804 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/T/tmp42LVKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:35 INFO - 2015-11-04 05:29:35,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 233041920 05:29:35 INFO - 2015-11-04 05:29:35,940 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 05:29:58 INFO - 2015-11-04 05:29:58,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 252796928 05:29:58 INFO - 2015-11-04 05:29:58,757 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:58 INFO - 2015-11-04 05:29:58,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |0;Richards;199.36204146730464 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;239.12003825920613 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |2;Encrypt;376.7897513187641 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6823.1292517006805 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1366.120218579235 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |5;Earley;1081.081081081081 05:29:58 INFO - 2015-11-04 05:29:58,758 DEBUG : BROWSER_OUTPUT: |6;Boyer;14955.223880597016 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: |7;RegExp;34810.34482758621 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: |8;Splay;813.6696501220505 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6856.164383561644 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: __startTimestamp1446643798751__endTimestamp 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,759 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.36 Median:199.36 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: Values: 199.4 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:239.12 Median:239.12 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: Values: 239.1 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,760 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:376.79 Median:376.79 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: Values: 376.8 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6823.13 Median:6823.13 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: Values: 6823.1 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1366.12 Median:1366.12 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: Values: 1366.1 05:29:58 INFO - 2015-11-04 05:29:58,761 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: Values: 1081.1 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14955.22 Median:14955.22 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: Values: 14955.2 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34810.34 Median:34810.34 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: Values: 34810.3 05:29:58 INFO - 2015-11-04 05:29:58,762 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:813.67 Median:813.67 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: Values: 813.7 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: Values: 6856.2 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:58 INFO - 2015-11-04 05:29:58,763 DEBUG : BROWSER_OUTPUT: 05:29:59 INFO - 2015-11-04 05:29:59,447 INFO : Browser exited with error code: 0 05:29:59 INFO - 2015-11-04 05:29:59,471 INFO : Completed test v8_7 (00:00:39) 05:29:59 INFO - 2015-11-04 05:29:59,759 INFO : Completed test suite (00:20:15) 05:29:59 INFO - 2015-11-04 05:29:59,759 DEBUG : Working with test: dromaeo_css 05:29:59 INFO - 2015-11-04 05:29:59,760 DEBUG : Generating results file: dromaeo_css 05:29:59 INFO - 2015-11-04 05:29:59,760 DEBUG : Working with test: kraken 05:29:59 INFO - 2015-11-04 05:29:59,760 DEBUG : Generating results file: kraken 05:29:59 INFO - 2015-11-04 05:29:59,761 INFO : javascript benchmark 05:29:59 INFO - 2015-11-04 05:29:59,761 DEBUG : Working with test: v8_7 05:29:59 INFO - 2015-11-04 05:29:59,761 DEBUG : Generating results file: v8_7 05:29:59 INFO - 2015-11-04 05:29:59,761 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:59 INFO - 2015-11-04 05:29:59,822 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:29:59 INFO - 2015-11-04 05:29:59,822 DEBUG : process_Request line: dromaeo_css 5627.51 graph.html#tests=[[72,1,57]] 05:29:59 INFO - 2015-11-04 05:29:59,822 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:59 INFO - 2015-11-04 05:29:59,859 DEBUG : process_Request line: kraken 1897.90 graph.html#tests=[[232,1,57]] 05:29:59 INFO - 2015-11-04 05:29:59,859 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:59 INFO - 2015-11-04 05:29:59,892 DEBUG : process_Request line: v8_7 16140.34 graph.html#tests=[[230,1,57]] 05:29:59 INFO - 2015-11-04 05:29:59,893 INFO : javascript benchmark 05:29:59 INFO - 2015-11-04 05:29:59,895 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [274.5908596191675, 275.14430122319584, 279.9790015748818, 281.6254381672376, 282.6424572915262, 11970.880291197085, 14195.716085678294, 14731.631709207275, 14802.111873287611, 15134.0, 15049.548513544583, 15138.697226055472, 15428.0, 15581.065136091815, 15602.375904963816, 4312.18068566972, 4330.307150855863, 4520.254158063915, 4520.9095818083615, 4530.048689775152, 4415.646748260131, 4445.53321901199, 4454.265046267362, 4467.994701192222, 4509.7970591323465, 3136.294333774894, 3453.8100404477746, 4397.230484665187, 4416.425864637593, 4848.054629347261, 4841.588464980481, 4843.39457567804, 4867.269909513566, 4900.6569540132205, 4914.483979182188, 4131.958680413188, 4225.3239481683095, 4225.767582782945, 4231.809568569391, 4278.743275403485, 17770.644587108316, 18124.90937545317, 18146.818531814777, 18155.636887262182, 18448.53878653031, 1730.6106126121647, 1741.5733145379336, 1790.355472030068, 1808.52074200337, 1839.291872629034, 10823.458827058694, 11275.210735248536, 11389.601363952304, 11458.083353331713, 11575.47910344028, 1341.966450838727, 1365.6790654196257, 1371.7942308653683, 1378.6553361659585, 1425.4013314407973, 47601.76199119017, 48492.75753621209, 48834.26748598774, 50019.74990125062, 59506.40493595095, 14059.859401405854, 14283.78574321386, 14297.356618952172, 14879.10725356482, 15031.924840375728, 21066.78933210679, 21149.68275475869, 21354.89322553377, 21356.0, 21571.568568628853, 7714.112877019103, 7758.495697779626, 7809.492382995087, 7810.218978102258, 7815.6482958267015, 6431.228252609623, 6489.123968264318, 6504.707288172043, 6509.381608747161, 6533.379328963741, 6765.594064356154, 6923.6884340204815, 6946.687399067054, 6951.6871740771785, 6977.441804655616, 2686.8522231277075, 2808.9297767555977, 2863.6134121893692, 2892.117904039288, 2990.177701132206, 339.9031276086353, 341.46560632609885, 343.2568489220809, 344.8999790060854, 354.83322838265974, 8582.485050896841, 8841.911580884109, 9051.321150913576, 9167.12912273333, 9226.53867306632, 339.8148009334918, 346.9340825243196, 355.77408345700667, 360.27584555044024, 367.65807798746886, 4772.642051846056, 4883.902321953541, 4901.460839307744, 5169.948300517022, 5241.9213711794355, 338228.0, 344860.0, 345811.0, 346954.0, 355567.0, 57865.13202301969, 59957.0, 60948.08577871336, 61275.69362153161, 61622.0, 361.4163126550602, 369.79661186347937, 373.8373807393792, 376.3451594226027, 378.78977167672207, 8619.267362274277, 8860.955695221483, 9038.141376569216, 9122.680706175252, 9384.249260059316, 28177.154685359474, 28539.857300714193, 28583.714162858105, 28657.0, 29420.558691619215, 37459.250814983, 38057.0, 38145.42781858219, 38310.80844595759, 38362.80818595889, 6359.491240700825, 6384.0, 6498.512611554247, 6522.510811689048, 6531.673416329069, 9580.329376943548, 9737.513124343614, 9854.162396196403, 9961.900380996098, 9963.302568820112, 7300.817479563053, 7420.6289685516585, 7492.7752167435065, 7601.467897247139, 7908.52548847071, 7552.207018263003, 7572.697092116254, 7603.239676032353, 7763.650635721293, 8031.317338026333, 7836.529808211526, 8039.1156972734125, 8111.351091912751, 8127.268545830667, 8181.79545511367, 11772.76385979494, 12422.130450868352, 12423.254604723745, 12821.166624169398, 13245.0, 12461.688457788629, 12687.936560317139, 12829.294388808705, 12967.221966681653, 13041.673958151123], "dojo.html": [2629.2638061342823, 2649.2317228003885, 2651.2576478585993, 2703.3511957130295, 2715.1447294102354, 4384.539623339548, 4459.375687403766, 4513.729176249427, 4549.226631472649, 4605.171069207541, 4335.306350983843, 4387.29803231483, 4435.68950173488, 4473.396091527643, 4542.000759832839, 4122.134351786129, 4159.230542349667, 4176.081262122329, 4208.579142085798, 4217.978910105445, 489.66952145933107, 4134.958650413502, 4139.130782535671, 4166.270902592049, 4283.271843786548, 4135.400366946806, 4145.937810932838, 4168.2080404723, 4202.285611446062, 4212.473440819897, 4151.8546850860075, 4188.267053265667, 4192.559781222958, 4214.431051808028, 4253.957460425418, 3954.3277642800795, 4031.1937612477623, 4067.6949228807957, 4076.653484453825, 4124.587541245882, 4249.553796851348, 4388.802503887333, 4518.096380723836, 4546.47715512717, 4587.174308624446, 4497.325401189815, 4820.0841840050625, 4829.1307564638355, 4845.660803743739, 4850.514948505156, 4673.6027437667835, 4828.927566086511, 4876.585490233334, 4889.168841296988, 4955.430125535538, 4496.100779844044, 4534.297183936462, 4544.931826022612, 4557.065801510682, 4577.107464044512, 4758.833440829554, 4863.610911127102, 4927.507249275115, 4928.137575924199, 4931.556159945622, 4676.415448068991, 4693.460252070987, 4761.928571071437, 4779.30700048498, 4825.010872771073, 4780.1873681474235, 4816.879578010507, 4844.975775121173, 4849.224124140121, 4868.464468908417, 4581.083783243364, 4680.695754775997, 4689.62483001359, 4712.410948631421, 4777.259524773665, 4592.242280023758, 4639.8144074237325, 4661.370714953506, 4783.378160839069, 4788.521147885183, 3799.2971300308977, 3801.6198380162314, 3803.847846086181, 3816.3321418751607, 3843.5387753469204, 3314.5193946877566, 3435.261418794971, 3440.501127336572, 3483.320752453247, 3520.0319912024397, 4444.088961762831, 4460.843870464518, 4495.078508905666, 4522.5929666330185, 4539.909201815945, 4819.49395313494, 4839.758012099381, 4875.658703890765, 4878.804847806119, 4882.292067650171, 4381.539938306496, 4451.5103338632725, 4511.977440112844, 4539.341795439643, 4548.431446069241, 4231.174920890397, 4277.786110694453, 4287.721298115613, 4302.913941721211, 4344.761038142932, 4823.348847905488, 4887.926681099715, 4895.902081958412, 4936.43231028422, 4951.950480495149, 4746.406699162605, 4775.021120670323, 4872.731999740048, 4873.853784386474, 4881.072596206709, 4873.561379475864, 4881.73150476713, 4883.8290659826735, 4937.6716879717, 4964.751762411937, 4776.283557466408, 4782.378290822171, 4801.303810947463, 4827.08285425768, 4866.610671146371, 4614.054118905683, 4736.952630473651, 4788.401449818773, 4793.95206047949, 4851.708897466164, 4722.150012997693, 4733.502982186821, 4738.928916066193, 4776.116418462457, 4821.831235906727, 4686.133065382915, 4692.812287508598, 4718.0, 4744.596709279612, 4759.16714574941, 4401.075774087478, 4508.098380324014, 4522.0277640307495, 4536.659750518658, 4595.540445955377, 4548.56788605082, 4684.601808846286, 4734.73958932262, 4745.064685079883, 4808.206645903387, 4430.446194225722, 4476.888077798081, 4655.743934083523, 4694.4366675997735, 4723.527647235249], "mootools.html": [1382.460840272294, 1431.9355628996689, 1432.8352239492456, 1447.1823419767834, 1481.444458328127, 5555.083411237141, 5709.914351284724, 6025.156478093065, 6131.785387511438, 6166.938330616693, 5758.856028599287, 5784.161296611988, 5890.3226128995175, 5892.734826932788, 5898.262717160355, 1659.7427398753211, 1730.0484733396581, 1732.558197659595, 1750.1249375312343, 1752.4830175098377, 1801.5766294920684, 1805.918733656982, 1808.9457316280532, 1820.1263393571094, 1834.3304693786806, 1743.6948534006563, 1779.3594306049877, 1782.1623836796684, 1800.837924586787, 1801.8198180182007, 1752.0976697001054, 1777.8933264004202, 1780.7863056433246, 1795.6767781799272, 1801.3155001099499, 1807.2319264312614, 1808.4665023818006, 1811.9637607247912, 1827.4791684370023, 1828.9817101828944, 5940.495057920082, 6002.069679199731, 6062.181605483247, 6068.393160683941, 6076.088586711984, 3643.1802844360072, 3781.6029316921604, 3789.412641040643, 3792.8862134135743, 3798.4682144499793, 2009.7889721579315, 2076.1384025629345, 2301.9424514387106, 2309.642005489152, 2388.856668599872, 730.6675462664475, 754.2608243920988, 754.3658179226211, 766.8657984852629, 771.1093686791764, 7730.884036739453, 7755.379569634472, 7770.26182512666, 7783.143854176036, 7787.844243115106, 3320.236345640516, 3416.7095796857548, 3432.502287168347, 3454.360943225511, 3495.598006229316, 6728.360805723449, 6771.424428923498, 6832.5558838676325, 6846.836037873573, 6857.862842743217, 3769.3968964965475, 3777.206786574795, 3793.6585707285926, 3806.1245913440066, 3812.72273788284, 3397.9830100849335, 3443.139215196201, 3472.8610855565494, 3481.912952176165, 3506.0708912138302, 2889.7977141599886, 2912.1554749122943, 2914.664813546427, 2938.3682508260827, 2945.602343683618, 946.5503885654259, 948.9288303377136, 960.5629438605417, 967.1585720423277, 967.5210770668564, 1045.2839804733783, 1064.808334499782, 1096.9122470202365, 1112.6828853776635, 1120.843081968525, 5668.178114173422, 5670.432956704379, 5671.914921276184, 5690.459406356389, 5732.111522713986, 386.1909300016461, 390.29551659255316, 394.2056755637393, 394.8025987006497, 399.93201155803, 4588.472325682589, 4593.425821772278, 4595.0, 4633.235516139866, 4636.11913736389, 6797.762078327334, 6880.139982502187, 6954.09596752429, 6994.090768200102, 7018.789436316919, 6940.13248343957, 6947.687354068978, 6951.443884489228, 6976.162860456778, 7027.402670772939, 5679.545636349082, 5689.317281926195, 5697.715114244271, 5709.628874123168, 5727.0550359190265, 5498.642588231752, 5618.129189975561, 5631.042722737063, 5648.096304591246, 5677.914831277451, 6192.380761923771, 6273.059041143865, 6280.214973128359, 6322.557420980671, 6333.271673757393, 6373.362663733589, 6409.455196308366, 6421.0, 6444.452221561032, 6462.063000864754, 5052.267421223975, 5359.088954877758, 5399.757010934596, 5411.594130440154, 5418.160185171305, 5752.942470575241, 5760.971195143998, 5761.135829625589, 5789.94210057894, 5821.76712931478, 5420.186971954238, 5424.83725488236, 5437.864053398696, 5464.781408743605, 5524.14375771756, 5310.920336194883, 5311.3891902431715, 5336.439673834191, 5350.6254562180275, 5434.429384914685, 5423.0, 5438.945610544002, 5468.070428027166, 5476.835694929158, 5483.150111732688, 4977.8257760978195, 4982.352294201731, 4984.252362145562, 4988.700677959334, 4994.9500504994485, 4521.502634710114, 4753.5008824072975, 5046.444891062054, 5067.138586440387, 5094.083065048327], "ext.html": [450.3424999500727, 465.85092770313514, 469.4999825186176, 473.8104758096762, 493.4054464370434, 30795.69204307956, 31345.843270783615, 31429.68570314296, 31445.685543144562, 31487.370252594963, 35142.472862907074, 35995.820020899926, 36360.45459318112, 36368.0, 36473.90578282649, 7649.311561959423, 7726.420518461138, 7872.409569282327, 7877.527348359088, 7893.447458677895, 7461.552306861606, 7643.273888980538, 7654.234576542329, 7665.041869766279, 7675.692972281102, 7584.165741768401, 7679.616019199046, 7681.7695469136015, 7723.382129429632, 7756.689732410697, 7654.349380302653, 7737.187595302468, 7767.456278060538, 7770.0287464067, 7851.5681637509915, 7437.590932498711, 7585.051868516435, 7639.885401718979, 7655.272749088827, 7666.118396384376, 33586.496202556984, 33713.0, 33767.83116084428, 33810.66189338124, 33862.15344616404, 2187.5406164705432, 2288.6338185890177, 2491.700995880488, 2554.0, 2668.3462551674966, 22212.666809997863, 22515.211967581057, 22868.970896309707, 23249.18627848034, 23361.7663823363, 1926.749522562072, 2002.3092033248506, 2009.7186393904865, 2035.1960975414777, 2044.8057434543693, 203381.6618338169, 203620.0, 207209.0, 207891.0, 207926.0, 41812.58187418148, 42461.57538424638, 48419.75790121097, 48979.26531102036, 48998.75500622474, 50603.24095138576, 50869.49130508648, 51464.0, 52100.478995210324, 52227.73886130545, 11886.108541859223, 12060.396980150957, 12078.21491603043, 12093.093018023683, 12159.696007599881, 8743.431676940978, 8974.371793974358, 9008.0, 9054.366194366463, 9076.27389808827, 15693.529194124194, 15856.603584910239, 15902.76145857813, 15976.0, 16005.199740012953, 6791.660416979132, 6902.102726645604, 6954.687039083254, 7002.509824312249, 7043.964780176067, 749.243264303047, 760.9124950630637, 784.8744200927824, 825.7316372179066, 886.2394436164928, 23546.0, 23581.528369432515, 23597.410064748517, 23631.0, 23757.16849910245, 891.4517571693361, 911.7036962987056, 915.4736026784492, 973.3819024919086, 1045.3518818332682, 12257.877421225852, 12345.876541234473, 12357.25856448616, 12470.127091103535, 12472.189307694971, 259387.0, 259944.0, 265885.0, 266742.0, 266884.0, 45229.773851130536, 45509.08981820411, 45533.772331138134, 45580.0, 45731.77134114374, 1138.7267055906523, 1140.2417392434104, 1143.519721716881, 1149.9482523286472, 1162.0877611075434, 21800.127994880026, 21884.45288867791, 22253.443663908532, 22378.21676241389, 22461.213857514907, 33381.83309083439, 33884.32231355408, 33905.83047084749, 34043.14892127617, 34153.829230853684, 198449.0, 198707.0, 200123.0, 200554.0, 201574.0, 25135.622965655897, 26254.868725656248, 26485.867570662023, 26596.335091622863, 26643.33391665224, 32615.836920815244, 32804.179895501846, 41522.0, 45365.319520207886, 45395.773021136, 28978.27554311159, 33504.667995384574, 33784.0, 34038.65961340355, 34049.65950340564, 33326.833365833016, 33439.83280083681, 33473.49789753204, 33676.0, 33781.0, 32946.34107317888, 32948.1762955928, 33650.83174584209, 33969.49045764266, 34286.314273713884, 28498.430031399672, 29858.0, 29893.850530747208, 30186.094417167522, 30275.091747247618, 21734.782652173275, 21825.454363641034, 21849.563008739417, 22223.0, 22273.0], "prototype.html": [260.8878182381576, 262.8830170574095, 263.03335242982047, 265.0907387660325, 267.86472831220243, 5041.143005689032, 5112.590992720583, 5150.5107014833575, 5159.251908473269, 5161.561267292284, 4950.702957822533, 4984.476629953857, 5113.156329205686, 5117.974410127954, 5127.359080114986, 3895.7662540247675, 3930.7838068906126, 3945.0, 3953.3081710700512, 3982.6017398260233, 3916.7454115482547, 3935.5080614923136, 3950.0, 3955.940660890089, 3956.5449973253158, 3751.7936513491745, 3907.941380879289, 3908.9022774430723, 3911.1395492991496, 3926.0577461409343, 3931.253061918226, 3952.9604703953023, 3955.9011024724323, 3966.325724626806, 3971.384435412516, 3394.9660503395144, 3412.4710669846213, 3420.640832712554, 3434.862605495777, 3447.2933048725204, 4979.576735977446, 5026.070177017264, 5051.0150520648485, 5051.52010559, 5081.517255860687, 4459.44256967879, 4464.397306363664, 4478.484974227973, 4494.550544945512, 4510.864674059783, 5202.0, 5285.0, 5384.865378365533, 5417.079096553595, 5460.180972854104, 3686.6313368663186, 3717.8326975286177, 3729.0, 3739.383001804699, 3741.28915506053, 5594.608377413582, 5601.719914004324, 5648.661080335152, 5659.51894089003, 5670.914936275959, 3782.508273924372, 3788.6969042476535, 3797.8480860765812, 3805.82873770681, 3805.9429108563395, 3717.1078941054493, 3747.9437808432895, 3793.430985352164, 3891.377379619247, 3914.0410599402758, 4366.214081465367, 4382.583654552813, 4411.669124815651, 4433.689641725048, 4439.755813430293, 5378.408375078739, 5394.62237643369, 5400.243965844785, 5406.053940560386, 5411.621186516906, 1379.2620947792882, 1382.0, 1384.1625816381145, 1384.4808196926153, 1391.3947432866735, 889.2574700125339, 909.9954500227457, 918.8713580098791, 938.5823308627595, 939.6382392778829, 5179.689218646893, 5220.138677118233, 5234.136367499396, 5261.316028916293, 5283.498067683564, 5624.578156638268, 5653.378128405872, 5655.236543066716, 5687.971560142173, 5717.62835415705, 5143.537081662668, 5208.401033881077, 5210.21846722987, 5221.869453263623, 5235.921461178009, 3038.9696103039128, 3077.0614962436225, 3122.9687703122677, 3142.8742850285735, 3159.526071089355, 5688.203651488795, 5692.31692196939, 5730.512906402919, 5732.254806875079, 5733.197352370671, 5695.5443564514735, 5747.626404283708, 5775.624584402084, 5804.564657650693, 5835.978703726831, 5518.889622207614, 5670.206171136044, 5699.971500142473, 5713.085906254979, 5740.4213841194005, 5471.097268950579, 5584.664920104807, 5619.522340601095, 5633.521150702236, 5680.68756218412, 5481.232627432083, 5526.364468086222, 5535.972320138373, 5548.778048878, 5556.138798486241, 5641.464060914206, 5670.489655930986, 5685.289338832646, 5702.34423041339, 5742.454466825645, 3542.50404943303, 3619.7647152934974, 3822.6941844652915, 3844.788536630512, 3853.576106628325, 5380.408155103014, 5494.066008778437, 5520.447955204608, 5520.66875987442, 5598.32820061579, 5340.919886201632, 5378.435264297349, 5404.54061404785, 5431.8098866539485, 5452.345718513804, 5311.9468805313, 5352.892942141058, 5353.330833645794, 5356.384015838228, 5424.484673955968, 5235.554977826775, 5240.868978275574, 5242.266082748494, 5282.445343238905, 5283.788648454019, 5283.709395983258, 5428.077226871363, 5432.592555558428, 5440.727963601725, 5464.590155738256, 5308.920366194433, 5334.653247538898, 5348.064088784369, 5354.303940487712, 5379.65032272901], "yui.html": [537.4437457231763, 568.3208565763914, 611.9235095613049, 630.2405601250493, 631.4543836358845, 11179.776404471906, 11230.55077796887, 11386.601468948567, 11437.370944598044, 11516.884831151696, 9786.0, 10763.0, 10837.891621083787, 10845.945770271137, 10856.837147442775, 751.346328694037, 753.6796861333938, 762.6339357108591, 766.2069757800678, 768.5235154204402, 752.289086812962, 754.0950858969231, 761.980950476237, 764.354120767953, 766.0462723908713, 789.135896193667, 795.5862951265339, 796.2634563029204, 805.2350267246111, 805.7179987004531, 782.2451334462243, 791.3629528229773, 791.9643616037292, 800.0279660212811, 800.0958916424432, 583.5885700581123, 583.7519054401862, 585.5198737035632, 590.6160995353055, 595.1192235491453, 11201.495932682967, 11224.158188135922, 11265.774684506347, 11331.15016373767, 11335.093192544658, 7511.0, 7879.566623835687, 7919.762407127795, 9268.49023303718, 10212.438315892623, 7348.338649521515, 7388.0, 7507.887381689279, 7526.548407095537, 7673.155952845183, 2462.6429167770752, 2495.301315631626, 2518.6977562692596, 2586.935326616831, 2627.658404407434, 34417.0, 34673.30653386918, 34846.30307393863, 34858.65141348579, 35252.47121293183, 5641.52047075995, 5647.830565083054, 5662.631928924607, 5789.0, 5818.389069147764, 9629.807403852024, 9682.9031709682, 9707.70876873695, 9715.0, 9722.9027709722, 5330.573554115662, 5333.946660533345, 5334.653247538898, 5370.301860758154, 5418.756155972991, 3230.2570408806105, 3245.221146924768, 3245.626752923397, 3284.244623736506, 3307.7188438982475, 2159.913603455844, 2199.7030400895674, 2212.590670725921, 2217.4013016485783, 2222.833287503444, 330.51744453098746, 331.1373871065887, 368.4804425759666, 385.3102945727173, 386.9899562142805, 390.6581740976645, 473.1861198738165, 487.54171079185454, 497.4354108087347, 522.7151202594595, 6256.124142620037, 6633.867322653617, 6654.367835055758, 6892.483063770237, 6899.6205208713, 389.9785511796878, 415.02883253187684, 415.93552999285157, 438.2527790117841, 477.3698717692682, 2990.8055976361466, 3082.7018975454707, 3212.9678703213135, 3221.8066915984646, 3259.2014956335374, 49479.25781113286, 50074.49925500698, 50719.74640126776, 51063.489365106616, 51181.48818511842, 38520.80739596284, 38585.614143858766, 42237.57762422398, 43210.78394608007, 43374.13251734948, 40136.0, 40345.39481907774, 40660.59339406627, 40770.38844417336, 40808.9999999994, 6725.730970761115, 6827.590344579341, 6982.1272340957385, 7038.753643622448, 7117.537360071578, 28137.57793633138, 29184.124476265744, 29441.0, 29567.704322957357, 29573.408531829675, 36481.0, 37518.06204844901, 37589.4361584571, 37924.05189870275, 38221.4266786004, 9118.680846170351, 9159.908400916172, 9165.450072995642, 9166.17504424605, 9275.6289748412, 9001.594928228114, 9164.175224229584, 9484.336096473457, 9597.0, 9755.756106097404, 8402.41183117176, 8484.660613575636, 8690.30477561781, 8874.378793484395, 9070.954645226731, 8526.78683032929, 8674.132586741276, 8789.252913502423, 9059.320550958573, 9391.577379018097, 8342.097786373466, 8414.284785793276, 8490.108538603605, 8665.740027799176, 9254.953725231331, 7503.66233519482, 7553.433492487976, 7600.80997975055, 7642.694292228249, 7810.9218907812465, 6579.342065793382, 7486.737964171228, 7664.73173438927, 7667.424943129176, 7942.483738556975]}, "summary": {"suite": 5627.51260788704, "subtests": {"jquery.html": {"filtered": 6901.028165708248, "value": 6901.028165708248}, "dojo.html": {"filtered": 4421.464981497946, "value": 4421.464981497946}, "mootools.html": {"filtered": 3431.7308212382222, "value": 3431.7308212382222}, "ext.html": {"filtered": 15213.575911128155, "value": 15213.575911128155}, "prototype.html": {"filtered": 4071.1099076858777, "value": 4071.1099076858777}, "yui.html": {"filtered": 4896.806660615477, "value": 4896.806660615477}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0067.e"}, "testrun": {"date": 1446642583, "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": "45.0a1", "id": "20151104030036", "branch": "Firefox", "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e"}}, {"talos_counters": {}, "results": {"audio-dft": [198.0, 217.0, 208.0, 210.0, 203.0, 203.0, 203.0, 201.0, 205.0, 211.0], "ai-astar": [133.0, 124.0, 141.0, 139.0, 141.0, 145.0, 134.0, 134.0, 135.0, 141.0], "imaging-gaussian-blur": [143.0, 142.0, 158.0, 155.0, 144.0, 150.0, 149.0, 155.0, 150.0, 145.0], "audio-beat-detection": [181.0, 173.0, 192.0, 202.0, 163.0, 185.0, 186.0, 164.0, 204.0, 155.0], "json-stringify-tinderbox": [78.0, 82.0, 83.0, 82.0, 85.0, 87.0, 87.0, 88.0, 86.0, 83.0], "stanford-crypto-pbkdf2": [185.0, 189.0, 195.0, 194.0, 189.0, 190.0, 187.0, 188.0, 190.0, 186.0], "json-parse-financial": [70.0, 70.0, 74.0, 75.0, 74.0, 74.0, 80.0, 85.0, 77.0, 78.0], "stanford-crypto-sha256-iterative": [80.0, 84.0, 89.0, 87.0, 90.0, 89.0, 89.0, 92.0, 91.0, 92.0], "audio-fft": [79.0, 89.0, 97.0, 148.0, 83.0, 88.0, 89.0, 91.0, 119.0, 82.0], "imaging-darkroom": [156.0, 164.0, 163.0, 156.0, 156.0, 157.0, 163.0, 165.0, 156.0, 158.0], "stanford-crypto-ccm": [154.0, 164.0, 172.0, 168.0, 167.0, 172.0, 169.0, 161.0, 170.0, 162.0], "audio-oscillator": [104.0, 109.0, 149.0, 112.0, 111.0, 108.0, 146.0, 109.0, 110.0, 153.0], "stanford-crypto-aes": [105.0, 107.0, 114.0, 110.0, 112.0, 112.0, 111.0, 114.0, 107.0, 110.0], "imaging-desaturate": [134.0, 140.0, 137.0, 135.0, 134.0, 134.0, 134.0, 137.0, 133.0, 134.0]}, "summary": {"suite": 1897.9, "subtests": {"audio-fft": {"filtered": 96.5, "value": 96.5}, "stanford-crypto-pbkdf2": {"filtered": 189.3, "value": 189.3}, "audio-beat-detection": {"filtered": 180.5, "value": 180.5}, "stanford-crypto-ccm": {"filtered": 165.9, "value": 165.9}, "imaging-darkroom": {"filtered": 159.4, "value": 159.4}, "json-parse-financial": {"filtered": 75.7, "value": 75.7}, "audio-oscillator": {"filtered": 121.1, "value": 121.1}, "ai-astar": {"filtered": 136.7, "value": 136.7}, "audio-dft": {"filtered": 205.9, "value": 205.9}, "stanford-crypto-sha256-iterative": {"filtered": 88.3, "value": 88.3}, "json-stringify-tinderbox": {"filtered": 84.1, "value": 84.1}, "imaging-gaussian-blur": {"filtered": 149.1, "value": 149.1}, "stanford-crypto-aes": {"filtered": 110.2, "value": 110.2}, "imaging-desaturate": {"filtered": 135.2, "value": 135.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0067.e"}, "testrun": {"date": 1446642583, "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": "45.0a1", "id": "20151104030036", "branch": "Firefox", "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [239.12003825920613], "Encrypt": [376.7897513187641], "NavierStokes": [6856.164383561644], "Decrypt": [6823.1292517006805], "Splay": [813.6696501220505], "Richards": [199.36204146730464], "RegExp": [34810.34482758621], "Earley": [1081.081081081081], "Boyer": [14955.223880597016], "RayTrace": [1366.120218579235]}, "summary": {"suite": 16140.341694573995, "subtests": {"DeltaBlue": {"filtered": 276.50547599999993, "value": 276.50547599999993}, "Encrypt": {"filtered": 706.4443739999999, "value": 706.4443739999999}, "NavierStokes": {"filtered": 216.44755244755225, "value": 216.44755244755225}, "Decrypt": {"filtered": 39.01157228315055, "value": 39.01157228315055}, "Splay": {"filtered": 100.15243899999999, "value": 100.15243899999999}, "RegExp": {"filtered": 26.16995047052997, "value": 26.16995047052997}, "Richards": {"filtered": 177.07483199999996, "value": 177.07483199999996}, "Earley": {"filtered": 616.4782750000002, "value": 616.4782750000002}, "Boyer": {"filtered": 44.56389321357285, "value": 44.56389321357285}, "RayTrace": {"filtered": 541.6719479999998, "value": 541.6719479999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0067.e"}, "testrun": {"date": 1446642583, "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": "45.0a1", "id": "20151104030036", "branch": "Firefox", "revision": "6077f51254c69a1e14e1b61acba4af451bf1783e"}}] 05:29:59 INFO - RETURN: dromaeo_css: 5627.51 05:29:59 INFO - RETURN: kraken: 1897.90 05:29:59 INFO - RETURN: v8_7: 16140.34 05:29:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "16140.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1897.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5627.51"}}} 05:30:00 INFO - Return code: 0 05:30:00 INFO - # TBPL SUCCESS # 05:30:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:00 INFO - 2015-11-04 05:30:00.035 screenresolution[1666:10845] starting screenresolution argv=screenresolution get 05:30:00 INFO - 2015-11-04 05:30:00.038 screenresolution[1666:10845] Display 0: 1600x1200x32@60 05:30:00 INFO - 2015-11-04 05:30:00.045 screenresolution[1667:10848] starting screenresolution argv=screenresolution list 05:30:00 INFO - Available Modes on Display 0 05:30:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:00 INFO - Intel HD Graphics 3000: 05:30:00 INFO - Chipset Model: Intel HD Graphics 3000 05:30:00 INFO - Type: GPU 05:30:00 INFO - Bus: Built-In 05:30:00 INFO - VRAM (Total): 512 MB 05:30:00 INFO - VRAM (Dynamic, Max): 10 05:30:00 INFO - Vendor: Intel (0x8086) 05:30:00 INFO - Device ID: 0x0116 05:30:00 INFO - Revision ID: 0x0009 05:30:00 INFO - Displays: 05:30:00 INFO - Display: 05:30:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:00 INFO - Display Serial Number: 1600x1200 60 05:30:00 INFO - Main Display: Yes 05:30:00 INFO - Mirror: Off 05:30:00 INFO - Online: Yes 05:30:00 INFO - Rotation: Supported 05:30:00 INFO - Return code: 0 05:30:00 INFO - Running post-action listener: _resource_record_post_action 05:30:00 INFO - Running post-run listener: _resource_record_post_run 05:30:01 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 38536192; Write bytes: 693269504; Read time: 4520; Write time: 73204 05:30:01 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 334801408; Write bytes: 337440768; Read time: 37115; Write time: 8430 05:30:01 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 37446656; Write bytes: 345449472; Read time: 3952; Write time: 64021 05:30:01 INFO - Running post-run listener: _upload_blobber_files 05:30:01 INFO - Blob upload gear active. 05:30:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:30:01 INFO - Copying logs to upload dir... 05:30:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1331.148341 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2015-11-04 05:30:01.470449) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 05:30:01.474055) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010927 build_url: 'https://queue.taskcluster.net/v1/task/Ea5MltKGQKO8PvWstzAdCA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 05:30:01.501612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:30:01.501947) ========= 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.0rOzhtvxUw/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.He98ks2pUq/Listeners TMPDIR=/var/folders/0d/wgdyxjyj2r96yt9mnwtg9t0m00000w/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.005701 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 05:30:01.552014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 05:30:01.552363) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 05:30:01.552801) ========= ========= Total master_lag: 106.98 =========