builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0040 starttime: 1447728118.41 results: success (0) buildid: 20151116163503 builduid: c40ff71d758e4a578f36724c00ee43ba revision: 1ec80d27792a10df33e1f1635b7dad14b3f1f8e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.408858) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.409317) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.409673) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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.006547 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.471801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.472176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 18:41:58.499424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-11-16 18:41:58.499731) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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.029275 ========= master_lag: 5.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2015-11-16 18:42:03.735834) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:03.736234) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:03.736677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:03.737044) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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-16 18:42:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2015-11-16 18:42:03 (13.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.236934 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:04.047171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:04.047504) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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.064694 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:04.128213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:42:04.128581) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1ec80d27792a10df33e1f1635b7dad14b3f1f8e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1ec80d27792a10df33e1f1635b7dad14b3f1f8e2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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-16 18:42:04,220 truncating revision to first 12 chars 2015-11-16 18:42:04,220 Setting DEBUG logging. 2015-11-16 18:42:04,220 attempt 1/10 2015-11-16 18:42:04,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1ec80d27792a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 18:42:05,128 unpacking tar archive at: mozilla-inbound-1ec80d27792a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.337404 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 18:42:05.575842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:05.576190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:05.591766) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:05.592164) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 18:42:05.592685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2015-11-16 18:42:05.593040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:42:05 INFO - MultiFileLogger online at 20151116 18:42:05 in /builds/slave/test 18:42:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:42:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:42:05 INFO - {'append_to_log': False, 18:42:05 INFO - 'base_work_dir': '/builds/slave/test', 18:42:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:42:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:42:05 INFO - 'branch': 'Mozilla-Inbound', 18:42:05 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:05 INFO - 'config_files': ('talos/mac_config.py',), 18:42:05 INFO - 'default_actions': ('clobber', 18:42:05 INFO - 'read-buildbot-config', 18:42:05 INFO - 'download-and-extract', 18:42:05 INFO - 'populate-webroot', 18:42:05 INFO - 'create-virtualenv', 18:42:05 INFO - 'install', 18:42:05 INFO - 'run-tests'), 18:42:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:05 INFO - 'download_minidump_stackwalk': True, 18:42:05 INFO - 'download_symbols': 'ondemand', 18:42:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:05 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:05 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:05 INFO - 'installer_path': 'installer.exe', 18:42:05 INFO - 'log_level': 'info', 18:42:05 INFO - 'log_name': 'talos', 18:42:05 INFO - 'log_to_console': True, 18:42:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:42:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:42:05 INFO - 'opt_config_files': (), 18:42:05 INFO - 'pip_index': False, 18:42:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:42:05 INFO - 'cmd': ('bash', 18:42:05 INFO - '-c', 18:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:42:05 INFO - 'enabled': True, 18:42:05 INFO - 'halt_on_failure': False, 18:42:05 INFO - 'name': 'check_screen_resolution'},), 18:42:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:42:05 INFO - 'cmd': ('bash', 18:42:05 INFO - '-c', 18:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:42:05 INFO - 'enabled': True, 18:42:05 INFO - 'halt_on_failure': False, 18:42:05 INFO - 'name': 'check_screen_resolution'},), 18:42:05 INFO - 'run_cmd_checks_enabled': True, 18:42:05 INFO - 'sps_profile': False, 18:42:05 INFO - 'sps_profile_interval': 0, 18:42:05 INFO - 'suite': 'dromaeojs-e10s', 18:42:05 INFO - 'system_bits': '64', 18:42:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:05 INFO - 'title': 't-yosemite-r5-0040', 18:42:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:05 INFO - 'use_talos_json': True, 18:42:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:42:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:05 INFO - 'work_dir': 'build'} 18:42:05 INFO - ##### 18:42:05 INFO - ##### Running clobber step. 18:42:05 INFO - ##### 18:42:05 INFO - Running pre-action listener: _resource_record_pre_action 18:42:05 INFO - Running main action method: clobber 18:42:05 INFO - rmtree: /builds/slave/test/build 18:42:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:42:10 INFO - Running post-action listener: _resource_record_post_action 18:42:10 INFO - ##### 18:42:10 INFO - ##### Running read-buildbot-config step. 18:42:10 INFO - ##### 18:42:10 INFO - Running pre-action listener: _resource_record_pre_action 18:42:10 INFO - Running main action method: read_buildbot_config 18:42:10 INFO - Using buildbot properties: 18:42:10 INFO - { 18:42:10 INFO - "properties": { 18:42:10 INFO - "buildnumber": 195, 18:42:10 INFO - "product": "firefox", 18:42:10 INFO - "script_repo_revision": "production", 18:42:10 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 18:42:10 INFO - "repository": "", 18:42:10 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 18:42:10 INFO - "buildid": "20151116163503", 18:42:10 INFO - "slavename": "t-yosemite-r5-0040", 18:42:10 INFO - "pgo_build": "False", 18:42:10 INFO - "basedir": "/builds/slave/test", 18:42:10 INFO - "project": "", 18:42:10 INFO - "platform": "yosemite", 18:42:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:42:10 INFO - "slavebuilddir": "test", 18:42:10 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 18:42:10 INFO - "branch": "mozilla-inbound", 18:42:10 INFO - "repo_path": "integration/mozilla-inbound", 18:42:10 INFO - "stage_platform": "macosx64", 18:42:10 INFO - "builduid": "c40ff71d758e4a578f36724c00ee43ba", 18:42:10 INFO - "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2" 18:42:10 INFO - }, 18:42:10 INFO - "sourcestamp": { 18:42:10 INFO - "repository": "", 18:42:10 INFO - "hasPatch": false, 18:42:10 INFO - "project": "", 18:42:10 INFO - "branch": "mozilla-inbound-macosx64-talos", 18:42:10 INFO - "changes": [ 18:42:10 INFO - { 18:42:10 INFO - "category": null, 18:42:10 INFO - "files": [ 18:42:10 INFO - { 18:42:10 INFO - "url": null, 18:42:10 INFO - "name": "https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:42:10 INFO - } 18:42:10 INFO - ], 18:42:10 INFO - "repository": "", 18:42:10 INFO - "rev": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2", 18:42:10 INFO - "who": "cmccormack@mozilla.com", 18:42:10 INFO - "when": 1447725399, 18:42:10 INFO - "number": 6669434, 18:42:10 INFO - "comments": "Bug 1225004 - Record reason for NS_ERROR_FILE_CORRUPTED in nsLayoutStylesheetCache::LoadSheet in crash reports. r=roc", 18:42:10 INFO - "project": "", 18:42:10 INFO - "at": "Mon 16 Nov 2015 17:56:39", 18:42:10 INFO - "branch": "mozilla-inbound-macosx64-talos", 18:42:10 INFO - "revlink": "", 18:42:10 INFO - "properties": [ 18:42:10 INFO - [ 18:42:10 INFO - "buildid", 18:42:10 INFO - "20151116163503", 18:42:10 INFO - "Change" 18:42:10 INFO - ], 18:42:10 INFO - [ 18:42:10 INFO - "builduid", 18:42:10 INFO - "c40ff71d758e4a578f36724c00ee43ba", 18:42:10 INFO - "Change" 18:42:10 INFO - ], 18:42:10 INFO - [ 18:42:10 INFO - "pgo_build", 18:42:10 INFO - "False", 18:42:10 INFO - "Change" 18:42:10 INFO - ] 18:42:10 INFO - ], 18:42:10 INFO - "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2" 18:42:10 INFO - } 18:42:10 INFO - ], 18:42:10 INFO - "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2" 18:42:10 INFO - } 18:42:10 INFO - } 18:42:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:42:10 INFO - Running post-action listener: _resource_record_post_action 18:42:10 INFO - ##### 18:42:10 INFO - ##### Running download-and-extract step. 18:42:10 INFO - ##### 18:42:10 INFO - Running pre-action listener: _resource_record_pre_action 18:42:10 INFO - Running main action method: download_and_extract 18:42:10 INFO - mkdir: /builds/slave/test/build/tests 18:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:10 INFO - https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/test_packages.json 18:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/test_packages.json 18:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:42:10 INFO - Downloaded 1149 bytes. 18:42:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:42:10 INFO - Using the following test package requirements: 18:42:10 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:42:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:42:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'jsshell-mac.zip'], 18:42:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:42:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:42:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:42:10 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:42:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:42:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:42:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:42:10 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:42:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:10 INFO - https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:42:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:12 INFO - Downloaded 17464400 bytes. 18:42:12 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 18:42:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:42:17 INFO - Return code: 0 18:42:17 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 18:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:17 INFO - https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:18 INFO - Downloaded 17464400 bytes. 18:42:18 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 18:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:42:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:42:24 INFO - Return code: 0 18:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:24 INFO - https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:42:24 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:42:24 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 18:42:24 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 18:42:25 INFO - Server: 10.26.75.40 18:42:25 INFO - Address: 10.26.75.40#53 18:42:25 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 18:42:25 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 18:42:25 INFO - Address: 10.26.48.46 18:42:25 INFO - Return code: 0 18:42:25 INFO - retry: attempt #1 caught exception: 18:42:25 INFO - retry: Failed, sleeping 30 seconds before retrying 18:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 #2 18:42:56 INFO - Downloaded 11131693 bytes. 18:42:56 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 18:42:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:42:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:42:56 INFO - Return code: 0 18:42: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')]} 18:42:56 INFO - https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:42:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:42:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:42:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/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 18:43:00 INFO - Downloaded 108734964 bytes. 18:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:43:00 INFO - mkdir: /builds/slave/test/properties 18:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:00 INFO - Contents: 18:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:43:00 INFO - Running post-action listener: _resource_record_post_action 18:43:00 INFO - Running post-action listener: set_extra_try_arguments 18:43:00 INFO - ##### 18:43:00 INFO - ##### Running populate-webroot step. 18:43:00 INFO - ##### 18:43:00 INFO - Running pre-action listener: _resource_record_pre_action 18:43:00 INFO - Running main action method: populate_webroot 18:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:43:00 INFO - '../fennec_ids.txt'], 18:43:00 INFO - 'tests': ['tcheck2']}, 18:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:00 INFO - '--tppagecycles', 18:43:00 INFO - '7'], 18:43:00 INFO - 'tests': ['tsvgm']}}, 18:43:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:43:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:43:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:43:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'tests': ['damp', 'tps']}, 18:43:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['damp', 'tps']}, 18:43:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:00 INFO - 'other': {'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'other_l64': {'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'other_nol64': {'tests': ['a11yr', 18:43:00 INFO - 'ts_paint', 18:43:00 INFO - 'tpaint', 18:43:00 INFO - 'sessionrestore', 18:43:00 INFO - 'sessionrestore_no_auto_restore']}, 18:43:00 INFO - 'svgr': {'tests': ['tsvgx', 18:43:00 INFO - 'tsvgr_opacity', 18:43:00 INFO - 'tart', 18:43:00 INFO - 'tscrollx', 18:43:00 INFO - 'cart']}, 18:43:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['tsvgx', 18:43:00 INFO - 'tsvgr_opacity', 18:43:00 INFO - 'tart', 18:43:00 INFO - 'tscrollx', 18:43:00 INFO - 'cart']}, 18:43:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'tests': ['tp5o']}, 18:43:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'talos_options': ['--e10s'], 18:43:00 INFO - 'tests': ['tp5o']}, 18:43:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'talos_options': ['--xperf_path', 18:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:00 INFO - 'tests': ['tp5n']}, 18:43:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:00 INFO - 'talos_options': ['--e10s', 18:43:00 INFO - '--xperf_path', 18:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:00 INFO - 'tests': ['tp5n']}}, 18:43:00 INFO - 'talos.zip': {'path': '', 18:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:00 INFO - Running post-action listener: _resource_record_post_action 18:43:00 INFO - ##### 18:43:00 INFO - ##### Running create-virtualenv step. 18:43:00 INFO - ##### 18:43:00 INFO - Running pre-action listener: _resource_record_pre_action 18:43:00 INFO - Running main action method: create_virtualenv 18:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43:00 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 18:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:00 INFO - Using real prefix '/tools/python27' 18:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:05 INFO - Installing pip.................done. 18:43:05 INFO - Return code: 0 18:43:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:05 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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:05 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 18:43:05 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 18:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:05 INFO - 'HOME': '/Users/cltbld', 18:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:05 INFO - 'LOGNAME': 'cltbld', 18:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:05 INFO - 'MOZ_NO_REMOTE': '1', 18:43:05 INFO - 'NO_EM_RESTART': '1', 18:43:05 INFO - 'PAGER': '/bin/cat', 18:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:05 INFO - 'PWD': '/builds/slave/test', 18:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:05 INFO - 'SHELL': '/bin/bash', 18:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:05 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:05 INFO - 'USER': 'cltbld', 18:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:05 INFO - 'XPC_FLAGS': '0x0', 18:43:05 INFO - 'XPC_SERVICE_NAME': '0', 18:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:06 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 18:43:06 INFO - Cleaning up... 18:43:06 INFO - Return code: 0 18:43:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:06 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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:06 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 18:43:06 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 18:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:06 INFO - 'HOME': '/Users/cltbld', 18:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:06 INFO - 'LOGNAME': 'cltbld', 18:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:06 INFO - 'MOZ_NO_REMOTE': '1', 18:43:06 INFO - 'NO_EM_RESTART': '1', 18:43:06 INFO - 'PAGER': '/bin/cat', 18:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:06 INFO - 'PWD': '/builds/slave/test', 18:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:06 INFO - 'SHELL': '/bin/bash', 18:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:06 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:06 INFO - 'USER': 'cltbld', 18:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:06 INFO - 'XPC_FLAGS': '0x0', 18:43:06 INFO - 'XPC_SERVICE_NAME': '0', 18:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:06 INFO - Downloading/unpacking psutil>=0.7.1 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:43:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:43:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:09 INFO - Installing collected packages: psutil 18:43:09 INFO - Running setup.py install for psutil 18:43:10 INFO - building 'psutil._psutil_osx' extension 18:43:10 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 18:43:11 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 18:43:11 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 18:43:12 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 18:43:12 INFO - building 'psutil._psutil_posix' extension 18:43:12 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 18:43:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:43:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:43:12 INFO - ^ 18:43:12 INFO - 1 warning generated. 18:43:12 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 18:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:12 INFO - Successfully installed psutil 18:43:12 INFO - Cleaning up... 18:43:12 INFO - Return code: 0 18:43:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:12 INFO - 'HOME': '/Users/cltbld', 18:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:12 INFO - 'LOGNAME': 'cltbld', 18:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:12 INFO - 'MOZ_NO_REMOTE': '1', 18:43:12 INFO - 'NO_EM_RESTART': '1', 18:43:12 INFO - 'PAGER': '/bin/cat', 18:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:12 INFO - 'PWD': '/builds/slave/test', 18:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:12 INFO - 'SHELL': '/bin/bash', 18:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:12 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:12 INFO - 'USER': 'cltbld', 18:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:12 INFO - 'XPC_FLAGS': '0x0', 18:43:12 INFO - 'XPC_SERVICE_NAME': '0', 18:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:43:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:43:16 INFO - Installing collected packages: mozsystemmonitor 18:43:16 INFO - Running setup.py install for mozsystemmonitor 18:43:16 INFO - Successfully installed mozsystemmonitor 18:43:16 INFO - Cleaning up... 18:43:16 INFO - Return code: 0 18:43:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:16 INFO - 'HOME': '/Users/cltbld', 18:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:16 INFO - 'LOGNAME': 'cltbld', 18:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:16 INFO - 'MOZ_NO_REMOTE': '1', 18:43:16 INFO - 'NO_EM_RESTART': '1', 18:43:16 INFO - 'PAGER': '/bin/cat', 18:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:16 INFO - 'PWD': '/builds/slave/test', 18:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:16 INFO - 'SHELL': '/bin/bash', 18:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:16 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:16 INFO - 'USER': 'cltbld', 18:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:16 INFO - 'XPC_FLAGS': '0x0', 18:43:16 INFO - 'XPC_SERVICE_NAME': '0', 18:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43:19 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 18:43:19 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 18:43:19 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 18:43:19 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 18:43:19 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 18:43:19 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 18:43:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:21 INFO - Downloading docopt-0.6.1.tar.gz 18:43:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:21 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:21 INFO - Running setup.py install for blobuploader 18:43:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:21 INFO - Running setup.py install for requests 18:43:22 INFO - Running setup.py install for docopt 18:43:22 INFO - Successfully installed blobuploader requests docopt 18:43:22 INFO - Cleaning up... 18:43:22 INFO - Return code: 0 18:43:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:22 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')]} 18:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:22 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')]} 18:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:22 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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:22 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 18:43:22 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 18:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:22 INFO - 'HOME': '/Users/cltbld', 18:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:22 INFO - 'LOGNAME': 'cltbld', 18:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:22 INFO - 'MOZ_NO_REMOTE': '1', 18:43:22 INFO - 'NO_EM_RESTART': '1', 18:43:22 INFO - 'PAGER': '/bin/cat', 18:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:22 INFO - 'PWD': '/builds/slave/test', 18:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:22 INFO - 'SHELL': '/bin/bash', 18:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:22 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:22 INFO - 'USER': 'cltbld', 18:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:22 INFO - 'XPC_FLAGS': '0x0', 18:43:22 INFO - 'XPC_SERVICE_NAME': '0', 18:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:22 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-aLr5sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:22 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-qUGaVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-rszHTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-BA1NeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-w9dM34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-OKVJRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-gQCZEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-jrPfTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:23 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-saTy5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-3bTita-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-LZxPdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-jxA5NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-Q6DTAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-CQXh51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-RCHgZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:24 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-Ookcif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:25 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-mjS8iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:43:25 INFO - Running setup.py install for manifestparser 18:43:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:43:25 INFO - Running setup.py install for mozcrash 18:43:25 INFO - Running setup.py install for mozdebug 18:43:25 INFO - Running setup.py install for mozdevice 18:43:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Running setup.py install for mozfile 18:43:26 INFO - Running setup.py install for mozhttpd 18:43:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Running setup.py install for mozinfo 18:43:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Running setup.py install for mozInstall 18:43:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:43:26 INFO - Running setup.py install for mozleak 18:43:27 INFO - Running setup.py install for mozlog 18:43:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:43:27 INFO - Running setup.py install for moznetwork 18:43:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:43:27 INFO - Running setup.py install for mozprocess 18:43:27 INFO - Running setup.py install for mozprofile 18:43:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:43:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:43:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:43:27 INFO - Running setup.py install for mozrunner 18:43:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:43:28 INFO - Running setup.py install for mozscreenshot 18:43:28 INFO - Running setup.py install for moztest 18:43:28 INFO - Running setup.py install for mozversion 18:43:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:43:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:43:28 INFO - Cleaning up... 18:43:28 INFO - Return code: 0 18:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:28 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')]} 18:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:28 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')]} 18:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:28 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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:28 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 18:43:28 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 18:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:28 INFO - 'HOME': '/Users/cltbld', 18:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:28 INFO - 'LOGNAME': 'cltbld', 18:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:28 INFO - 'MOZ_NO_REMOTE': '1', 18:43:28 INFO - 'NO_EM_RESTART': '1', 18:43:28 INFO - 'PAGER': '/bin/cat', 18:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:28 INFO - 'PWD': '/builds/slave/test', 18:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:28 INFO - 'SHELL': '/bin/bash', 18:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:28 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:28 INFO - 'USER': 'cltbld', 18:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:28 INFO - 'XPC_FLAGS': '0x0', 18:43:28 INFO - 'XPC_SERVICE_NAME': '0', 18:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-3qqenS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:29 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)) 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-LpkIOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:29 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)) 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-wEzcox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:29 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)) 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-a0ojte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:29 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)) 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-N7tKPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:29 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)) 18:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:29 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-F1CVMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-gXiONo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-Su6yf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-INwcTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-RDOXtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-m8K1pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-IhG61j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:30 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)) 18:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:30 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-uQFxYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:31 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)) 18:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:31 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-eIcywr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:31 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)) 18:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:31 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-jrZ3JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:31 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)) 18:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:31 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-9H3ULS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:31 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)) 18:43:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:31 INFO - Running setup.py (path:/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/pip-E9l85L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:31 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)) 18:43:31 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)) 18:43:31 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)) 18:43:31 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)) 18:43:31 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)) 18:43:31 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)) 18:43:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43: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 18:43:34 INFO - Downloading blessings-1.5.1.tar.gz 18:43:34 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 18:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:34 INFO - Installing collected packages: blessings 18:43:34 INFO - Running setup.py install for blessings 18:43:34 INFO - Successfully installed blessings 18:43:34 INFO - Cleaning up... 18:43:35 INFO - Return code: 0 18:43:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:43:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:35 INFO - Reading from file tmpfile_stdout 18:43:35 INFO - Current package versions: 18:43:35 INFO - blessings == 1.5.1 18:43:35 INFO - blobuploader == 1.2.4 18:43:35 INFO - docopt == 0.6.1 18:43:35 INFO - manifestparser == 1.1 18:43:35 INFO - mozInstall == 1.12 18:43:35 INFO - mozcrash == 0.16 18:43:35 INFO - mozdebug == 0.1 18:43:35 INFO - mozdevice == 0.47 18:43:35 INFO - mozfile == 1.2 18:43:35 INFO - mozhttpd == 0.7 18:43:35 INFO - mozinfo == 0.9 18:43:35 INFO - mozleak == 0.1 18:43:35 INFO - mozlog == 3.0 18:43:35 INFO - moznetwork == 0.27 18:43:35 INFO - mozprocess == 0.22 18:43:35 INFO - mozprofile == 0.27 18:43:35 INFO - mozrunner == 6.11 18:43:35 INFO - mozscreenshot == 0.1 18:43:35 INFO - mozsystemmonitor == 0.0 18:43:35 INFO - moztest == 0.7 18:43:35 INFO - mozversion == 1.4 18:43:35 INFO - psutil == 3.1.1 18:43:35 INFO - requests == 1.2.3 18:43:35 INFO - wsgiref == 0.1.2 18:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10e7cf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e7ac228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed8d980d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, '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.mbRYssd0QQ/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.pF3ievJXKi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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 18:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 18:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 18:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:35 INFO - 'HOME': '/Users/cltbld', 18:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:35 INFO - 'LOGNAME': 'cltbld', 18:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:35 INFO - 'MOZ_NO_REMOTE': '1', 18:43:35 INFO - 'NO_EM_RESTART': '1', 18:43:35 INFO - 'PAGER': '/bin/cat', 18:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:35 INFO - 'PWD': '/builds/slave/test', 18:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:35 INFO - 'SHELL': '/bin/bash', 18:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:43:35 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:35 INFO - 'USER': 'cltbld', 18:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:35 INFO - 'XPC_FLAGS': '0x0', 18:43:35 INFO - 'XPC_SERVICE_NAME': '0', 18:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 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)) 18:43:35 INFO - Cleaning up... 18:43:35 INFO - Return code: 0 18:43:35 INFO - Running post-action listener: _resource_record_post_action 18:43:35 INFO - Running post-action listener: _start_resource_monitoring 18:43:35 INFO - Starting resource monitoring. 18:43:35 INFO - ##### 18:43:35 INFO - ##### Running install step. 18:43:35 INFO - ##### 18:43:35 INFO - Running pre-action listener: _resource_record_pre_action 18:43:35 INFO - Running main action method: install 18:43:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:36 INFO - Reading from file tmpfile_stdout 18:43:36 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:43:36 INFO - Reading from file tmpfile_stdout 18:43:36 INFO - Output received: 18:43:36 INFO - Usage: mozinstall [options] installer 18:43:36 INFO - Options: 18:43:36 INFO - -h, --help show this help message and exit 18:43:36 INFO - -d DEST, --destination=DEST 18:43:36 INFO - Directory to install application into. [default: 18:43:36 INFO - "/builds/slave/test"] 18:43:36 INFO - --app=APP Application being installed. [default: firefox] 18:43:36 INFO - mkdir: /builds/slave/test/build/application 18:43:36 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'] 18:43:36 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 18:44:20 INFO - Reading from file tmpfile_stdout 18:44:20 INFO - Output received: 18:44:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:44:20 INFO - Running post-action listener: _resource_record_post_action 18:44:20 INFO - ##### 18:44:20 INFO - ##### Running run-tests step. 18:44:20 INFO - ##### 18:44:20 INFO - Running pre-action listener: _resource_record_pre_action 18:44:20 INFO - Running main action method: run_tests 18:44:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:44:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:44:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:44:20 INFO - 2015-11-16 18:44:20.574 screenresolution[1625:7552] starting screenresolution argv=screenresolution get 18:44:20 INFO - 2015-11-16 18:44:20.577 screenresolution[1625:7552] Display 0: 1600x1200x32@60 18:44:20 INFO - 2015-11-16 18:44:20.585 screenresolution[1626:7554] starting screenresolution argv=screenresolution list 18:44:20 INFO - Available Modes on Display 0 18:44:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:44:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:44:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:44:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:44:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:44:20 INFO - Intel HD Graphics 3000: 18:44:20 INFO - Chipset Model: Intel HD Graphics 3000 18:44:20 INFO - Type: GPU 18:44:20 INFO - Bus: Built-In 18:44:20 INFO - VRAM (Total): 512 MB 18:44:20 INFO - VRAM (Dynamic, Max): 10 18:44:20 INFO - Vendor: Intel (0x8086) 18:44:20 INFO - Device ID: 0x0116 18:44:20 INFO - Revision ID: 0x0009 18:44:20 INFO - Displays: 18:44:20 INFO - Display: 18:44:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:44:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:44:20 INFO - Display Serial Number: 1600x1200 60 18:44:20 INFO - Main Display: Yes 18:44:20 INFO - Mirror: Off 18:44:20 INFO - Online: Yes 18:44:20 INFO - Rotation: Supported 18:44:20 INFO - Return code: 0 18:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:20 INFO - Python 2.7.3 18:44:20 INFO - Return code: 0 18:44:20 INFO - grabbing minidump binary from tooltool 18:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6f29f0>, '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 0x10e452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e6e68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:44:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:44:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:21 INFO - Return code: 0 18:44:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:44:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:44:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0040', '--webServer', 'localhost'] in /builds/slave/test/build 18:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0040 --webServer localhost 18:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mbRYssd0QQ/Render', 18:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:21 INFO - 'HOME': '/Users/cltbld', 18:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:21 INFO - 'LOGNAME': 'cltbld', 18:44:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:21 INFO - 'MOZ_NO_REMOTE': '1', 18:44:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:21 INFO - 'NO_EM_RESTART': '1', 18:44:21 INFO - 'PAGER': '/bin/cat', 18:44:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:21 INFO - 'PWD': '/builds/slave/test', 18:44:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:21 INFO - 'SHELL': '/bin/bash', 18:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pF3ievJXKi/Listeners', 18:44:21 INFO - 'TMPDIR': '/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/', 18:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:21 INFO - 'USER': 'cltbld', 18:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:21 INFO - 'XPC_FLAGS': '0x0', 18:44:21 INFO - 'XPC_SERVICE_NAME': '0', 18:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:44:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0040', '--webServer', 'localhost'] with output_timeout 3600 18:44:21 INFO - mozversion INFO | application_buildid: 20151116163503 18:44:21 INFO - mozversion INFO | application_changeset: 1ec80d27792a10df33e1f1635b7dad14b3f1f8e2 18:44:21 INFO - mozversion INFO | application_display_name: Nightly 18:44:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:21 INFO - mozversion INFO | application_name: Firefox 18:44:21 INFO - mozversion INFO | application_remotingname: firefox 18:44:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:44:21 INFO - mozversion INFO | application_vendor: Mozilla 18:44:21 INFO - mozversion INFO | application_version: 45.0a1 18:44:21 INFO - mozversion INFO | platform_buildid: 20151116163503 18:44:21 INFO - mozversion INFO | platform_changeset: 1ec80d27792a10df33e1f1635b7dad14b3f1f8e2 18:44:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:44:21 INFO - mozversion INFO | platform_version: 45.0a1 18:44:21 INFO - 2015-11-16 18:44:21,366 DEBUG : using testdate: 1447728261 18:44:21 INFO - 2015-11-16 18:44:21,366 DEBUG : actual date: 1447728261 18:44:21 INFO - 2015-11-16 18:44:21,376 INFO : starting webserver on 'localhost:49269' 18:44:21 INFO - 2015-11-16 18:44:21,377 INFO : Starting test suite t-yosemite-r5-0040.e 18:44:21 INFO - 2015-11-16 18:44:21,377 INFO : Starting test dromaeo_css 18:44:21 INFO - 2015-11-16 18:44:21,377 DEBUG : operating with platform_type : mac_ 18:44:21 INFO - 2015-11-16 18:44:21,378 INFO : Initialising browser for dromaeo_css test... 18:44:21 INFO - 2015-11-16 18:44:21,409 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmp9FOziT/profile http://localhost:49269/getInfo.html 18:44:25 INFO - 2015-11-16 18:44:25,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:44:25 INFO - 2015-11-16 18:44:25,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:44:25 INFO - 2015-11-16 18:44:25,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:44:25 INFO - 2015-11-16 18:44:25,936 DEBUG : BROWSER_OUTPUT: __metrics 18:44:26 INFO - 2015-11-16 18:44:26,686 INFO : Browser initialized. 18:44:26 INFO - 2015-11-16 18:44:26,687 INFO : Running cycle 1/1 for dromaeo_css test... 18:44:26 INFO - 2015-11-16 18:44:26,687 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmp9FOziT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:44:39 INFO - 2015-11-16 18:44:39,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 241786880 18:44:39 INFO - 2015-11-16 18:44:39,078 DEBUG : BROWSER_OUTPUT: 18:45:28 INFO - 2015-11-16 18:45:28,953 DEBUG : BROWSER_OUTPUT: 1447728328951 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] 18:47:39 INFO - 2015-11-16 18:47:39,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 18:47:40 INFO - 2015-11-16 18:47:40,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 263983104 18:47:40 INFO - 2015-11-16 18:47:40,425 DEBUG : BROWSER_OUTPUT: 18:50:42 INFO - 2015-11-16 18:50:42,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 18:50:43 INFO - 2015-11-16 18:50:43,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 271167488 18:50:43 INFO - 2015-11-16 18:50:43,087 DEBUG : BROWSER_OUTPUT: 18:53:44 INFO - 2015-11-16 18:53:44,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 18:53:45 INFO - 2015-11-16 18:53:45,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 275546112 18:53:45 INFO - 2015-11-16 18:53:45,491 DEBUG : BROWSER_OUTPUT: 18:56:47 INFO - 2015-11-16 18:56:47,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 18:56:47 INFO - 2015-11-16 18:56:47,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 278294528 18:56:47 INFO - 2015-11-16 18:56:47,856 DEBUG : BROWSER_OUTPUT: 18:59:50 INFO - 2015-11-16 18:59:50,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 18:59:51 INFO - 2015-11-16 18:59:51,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 284934144 18:59:51 INFO - 2015-11-16 18:59:51,141 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 19:02:53 INFO - 2015-11-16 19:02:53,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 288079872 19:02:53 INFO - 2015-11-16 19:02:53,849 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,849 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:02:53 INFO - 2015-11-16 19:02:53,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:02:53 INFO - 2015-11-16 19:02:53,849 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:02:53 INFO - 2015-11-16 19:02:53,850 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:02:53 INFO - 2015-11-16 19:02:53,850 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2436.7928726058285;2514.924552263433;2547.3631592101974;2581.3804686875155;2584.392667723086;4199.286121359372;4231.767252801099;4294.742315461067;4297.183535128327;4298.011457364808;4064.756114633117;4125.46368972034;4150.439690641762;4187.413762073312;4368.432103826506;3869.1101046759263;3905.453236546886;3932.508436445444;3978.38335058065;4006.379011253246;524.6781663175262;3836.7889766062854;3901.9024524386978;3933.6656384207377;3952.387379956097;3821.14024344523;3965.3258945978964;3975.264576053425;3995.7802320872343;4000.119973605802;3897.2984862724697;3915.4909861717792;3934.645881870617;3963.147923196527;4003.6797056235723;3756.5116534850295;3850.7497012694084;3871.612838716134;3894.1627550076587;3914.725969182158;4042.797860106983;4127.215828992482;4141.855035073788;4235.745855248695;4289.420928174688;4466.441694788152;4517.59341659249;4535.092981403733;4584.816607335702;4638.79125439356;4396.8021439035;4409.162259170779;4501.864944051651;4542.318652202163;4670.322803193552;4197.265478541273;4255.446791917031;4304.504981927118;4332.718373305725;4349.282368409209;4550.47669518003;4609.677322587387;4626.537346265414;4720.0559888022535;4720.362751028636;4302.870913872589;4423.093265880551;4426.18115648606;4451.998300382453;4467.7319360838455;4421.469423669116;4517.932231016537;4567.5432456754725;4573.314002899591;4584.174848527297;4352.434183556117;4447.688661793643;4462.665300102441;4474.172278128557;4533.206688829442;4324;4444.622207112367;4495;4576.8626941191815;4604.332371806069;3460.377132116193;3493.458513930345;3521.57741071068;3610.981945090258;3635.2184280379315;3162.335909459039;3175.491921292582;3203.4874420092674;3253.3330667213163;3295.044437113258;4209.284421648327;4227.281362168439;4265.296226122655;4270.7010509264055;4359.04101097758;4520.547945205453;4537.636989040869;4542.772861356985;4560.338750881104;4663.743494107789;4067.186562687474;4093.1199792044854;4266.146770645883;4318.5681431856565;4351.934720979188;3916.804159791999;4000.27994960904;4043.2924238258774;4047.177153804675;4082.142750022469;4512.909741805145;4565.360849481075;4615.446146462446;4718.693284936468;4738.928916066331;4391.407160033355;4547.340635607752;4579.908401832011;4604.562566556172;4639.095376401569;4549.7042692224895;4589.701669391479;4594.7243165408845;4649.256119020941;4704.388429504143;4349.8042588084245;4498.662600305056;4502.30270822282;4574.4510658721165;4643.489216186149;4514.706544074625;4534.161180181677;4563.429571303587;4568.383268258743;4604.769761511978;4416.801243943966;4446.622037126751;4485.910281794411;4495;4509;4112.485939257593;4428.31361139024;4441.733495990251;4445.355423463644;4532.954670453253;4259.659227261874;4314.69797114199;4341.8046187922255;4402.625776809007;4422.3587579800105;4259.42497762798;4381.605655490894;4445.244308467633;4479.7536135512855;4480.238359478962;4222.556631553643;4229.725067870701;4364.323529852878;4381.058072514425;4428.778561071998 19:02:53 INFO - 2015-11-16 19:02:53,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;430.7178797887383;438.6994908487686;450.4189595421905;466.88327918020485;482.1658530741819;31086;32157.83921080391;32350.19124521885;32942.34115317695;33019.339613207725;34663.65336346636;34827.651723482755;35613;35908.82045589769;36028;7277.3086556777025;7457.993170921937;7560.773176804677;7577.507462014979;7601.391888648895;7277.708891644328;7281.308275713799;7365.189829118819;7371.37343325818;7452.925470745305;7271.127464704243;7370.226126256746;7408.148062972747;7439.181690014094;7450.888236676454;7255.673494692725;7310.671019804122;7468.290512401313;7481.289277518627;7513.549187048768;7303.415726741901;7305.707771689126;7368.226336234672;7441.925580744178;7504.662290196954;32054.358912821845;32323.51514727281;32730.018099457055;32923.3415331692;33193.6680633193;2037.7860324665844;2154.8707077575395;2196.690082152643;2536.1884197056947;2554.846709197454;21895;22110.88944555283;22496.88751556248;23006.194783182676;23264.418389540228;1880.2854915132161;1956.1099699636632;1988.1848442138653;2014.3654748754095;2025.0077462043494;193913;194932;197849;198479;199648;45559;48373.274400884016;49578.75210623996;49966.500334996184;50691.74654126706;57485;58409.70795146082;58808.41191588029;59174.40825591775;60168.09747853786;11459.541618335174;11474.196806223485;11479.942600286946;11609.76780464386;11624.070074394029;9973.750656233653;10121.39271643689;10195.184385249162;10203.234757393226;10234.795304093876;16527.33890644361;16933.322667093424;16949.661006779796;17075.146242688064;17153.313867445413;6564.6389448580785;6687.297833727389;6768.458523318122;6828.692708828015;6844.076049733222;684.3293572299175;751.7256201486418;775.3215936055951;782.7573452229827;796.4902462424053;22715.545689086124;23652.408689782893;23682.4079398013;23764.88117559401;23862.403439914142;810.6068556749972;837.2757564706607;854.2354592639678;867.4101610904519;957.2772556719632;11761.235519691192;11914;11969.46137423818;12070.758584828254;12167.452464639113;233043;236147;239033;241871.79064104566;242436;43055.13889722188;43380.34929476061;43616;43928.78035609866;44207.55792442099;1108.844761733358;1115.5816568786704;1116.4696769034645;1121.360824330124;1126.1947707389256;22682.65976010328;22846.771532284463;22976.310710678707;23194.768052319934;23320.183793567143;39464;39520.802395987834;39589.2082158361;39781.60218397779;40467.79766101151;223386;224704;224849;229834;229983;24529.877350613133;33515.329693406486;33821.49267760936;34559.82720086384;35003;35615.46576801298;35954.64045359618;37048.25903481969;37509.4373584391;37583.62416375801;28631.284217894718;29652.70347296586;29964.101076966854;30416.543751844183;30958.53562196614;29791;29949.700502994692;29978;30240;30285;30226.395472089996;31226.843865780527;31515;31851.36297274088;32091;24519.877400613597;26887.462250754485;26890.596641050008;27209.183724488295;27453.17640470789;20720.481987949817;21043.00091491306;21100.788992110498;21109.41140006172;21112.15551377928 19:02:53 INFO - 2015-11-16 19:02:53,855 DEBUG : BROWSER_OUTPUT: |2;jquery.html;262.41874248539506;263.3666033190177;266.46440654284885;269.7141030507663;275.64992459576337;11025.724356891082;13496.59510214694;13647.522336718217;13979.370928308224;14166.575002749922;13644.113132646396;13748.725025499509;14020.158790472578;14099.154050756935;14314.069585476936;4146.585341465852;4194.077302993352;4237.194932962742;4296.677749168824;4382.890427739316;3110.9066727998197;3212.5823642926503;4319.50325712544;4749.121412538691;4825.710457372569;4760.523947605247;4777.307290442884;4783.904321913559;4845.903081938359;4865.221564549673;4634.281686338606;4708.387909571768;4737.076270127326;4783.928241076386;4888.535589119028;4062.329715596923;4084.7344922580232;4091.85678501251;4123.711340206187;4170.562090980464;17071.658566828595;17289.30842766288;17303.567410814703;17383.826161738474;17600;1394.1983359568187;1494.12593632725;1570.8272090070084;1798.2537247042462;1827.6527459782599;7302.890456643155;7310.780676579711;7461.477696561243;7507.368232073144;7636.656350464243;1224.136983426682;1236.2397125767588;1244.695049712817;1263.3051821498232;1302.6808431934141;46638;47517.52482475166;47876.28185577219;48264;48306.51693483091;5072.51811077947;5082.567981721521;5084.186530155157;5156.819511317086;5232.529072383504;5797.507211886952;5828.941710582924;5847.093700476433;5892;5916.408359164049;4267.658587313008;4293.806778694966;4351.26028575143;4367.039251364695;4408.0522687622315;4572.154151481986;4635.096156249499;4683.742394168354;4710.010897711519;4746.928796068062;2268.3308424014626;2307.711536057993;2311.722593288816;2318.652202169654;2331.265651319829;809.3565615335822;823.518241828525;827.6565225431378;851.6040041380663;868.5440143924491;352.52585272808034;353.50156279645574;355.2965129044455;362.0442033032796;367.28746232309237;8723.302135829119;8988.10118988096;9033.593488293043;9135.817283654289;9608.66369677058;366.2473616717618;368.1495744829399;369.9981500092536;370.3223101723839;401.15356597579085;5000.374953130859;5040.84877453677;5085.203138273934;5099.554650210734;5125;462399;463663;478159;489089;499666;55224.895502089734;58977;59142.70428647829;60197.398026020055;60496.39503604996;377.8016541315776;394.2469882524365;395.72299390426815;395.83374982507416;401.3858796042002;8288.88100106478;8505.74482765518;8507.702230421906;8542.957285213533;8556.358273129665;26018.34954126162;26762.79567419432;29015.419691606472;29186.270343241587;29447.411051779272;35616.82191589129;37950.62049379471;38807.41788873113;39233.41149882697;39240.215195696495;4712.50518695532;4725.976370118127;4845.685030473008;4848.296996935495;4864.878378040577;8700.869486957827;8808.64765409402;9192.862107068266;9281.767955801159;9283.071692830663;6810.523263371517;7002.404795592432;7474.177840437439;7584.2794934481135;8002.83994320122;7599.506032107895;7700.691972321044;7868.134505204537;7906.52560846351;7916.802079948047;7869.606519673879;8083.474574152661;8090.595470226583;8176.959115204386;8194.098649148707;4851.733154676526;4858;4879.56083952446;4883.975580122076;4946.282788995503;7837.13791482925;8114.797130071795;8125.228103330174;8127.83744325122;8159 19:02:53 INFO - 2015-11-16 19:02:53,858 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1377.4490203918435;1397.7623803953327;1415.7663985442402;1424.8361438434583;1433.569929021294;5518.144687573423;5664.773409063643;5958.314793798714;6051.092336149574;6236.220472440945;5888.7644494220285;5936.109583562467;6095.116208149816;6163.2912215095275;6196.566240363177;1762.8237176282398;1793.865460090492;1807.6475087357971;1815.7639506864089;1817.2276782367508;1718.2525601363384;1741.3731056819536;1771.3977247735768;1774.1661419133052;1794.9948029103743;1741.982580174201;1742.3988723890238;1756.2272600055999;1757.2443849144863;1757.3146472875526;1651.6614094110678;1698.8131305556378;1701.6001239708658;1728;1732.7697334892305;1736.3315123677348;1753.8509226715744;1757.156564848867;1789.2395731814056;1793.757842691233;6113.23584551931;6113.755449782004;6127.356627554132;6150.815475535741;6213.782517611907;3540.805255710935;3630.981845090784;3701.796401197933;3777.338965680995;3787.753796003251;2009.1661960286463;2082.6147162774937;2172.2397160993683;2243.2036626997506;2276.533310671325;630.9905351419733;650.5088658063132;664.6311297230036;677.8440958579554;688.2016860441863;7917.485363451357;7961.1640777718085;7962.800929976739;8013.759587212393;8036.517808931424;3322.0864262328055;3332.683395077464;3352.7485438591716;3363.7140843028615;3384.5430866833153;7004.2645522220455;7034.2965703429245;7039.401650859734;7092.184398794205;7194.892076618855;3822.063594419385;3838.808059597065;3867.284552357823;3880.631340022693;3905.258000979805;3370.1237678203843;3429.2627085176805;3521.841517131735;3532.346515894568;3541.468779683068;2697.1369161868015;2713.8643067846924;2734.4394399148127;2772.459370422748;2806.593044008607;900.5587262241586;931.4783721116197;943.3302355327656;948.5352177433008;960.6925783749273;1006.4766321512918;1032.8450732390052;1054.6941386997837;1070.8768491623564;1083.1659622090947;5606.187102870061;5721.22763426932;5785.739641716133;5836.007878660638;5848.152017957457;386.08690447092425;390.41242929391086;958.3770549143113;977.8973207813219;1010.757418219622;4573.108243892476;4580.519045500241;4613.746243956548;4646.86059418218;4726.456457507362;6713.765018224339;6881.483888708367;6886.345797149263;7088.858222835617;7439.8140046499275;6912.481563882729;6916.273791251846;7009.61447120403;7117.501774875709;7145.96427017872;5716;5750.051241545182;5758.395368486249;5793.681347525927;5830.038043722739;5517.806876759294;5586.692731899622;5594.496495315441;5616.297962754656;5698.886022279614;6385.680715964276;6488.837779055561;6517.771877984437;6530.836729081621;6571.605703657796;6508.284088750139;6547.181602299713;6594.571352862049;6677.866442671217;6694.631795251308;4767.356406885026;4852.95147048525;4902.534259245366;4919.2129259318335;4963;5853.619514731528;5906.438888305604;5922.615030023035;5938.317093534126;5953.28560572734;5381.811636592701;5432.511074003359;5565.749541270571;5593.524550413261;5599.692016939108;5446.754896029609;5447;5460.863478413072;5473.616846820684;5546.473085056913;5206.921896171485;5465.344158700822;5566.248556444828;5596.720163991866;5617.297837770278;4814.422269327703;4825.638077144298;4897.338859254098;4902.63230257725;4908.63185261114;5140.12617854973;5146.176611742103;5153.7165455898785;5172.612054095883;5239.135542635575 19:02:53 INFO - 2015-11-16 19:02:53,860 DEBUG : BROWSER_OUTPUT: |4;prototype.html;242.46294457776023;247.20153902893665;253.45886532253644;256.9145360850407;258.20730357801557;5028.0698070856915;5099.541041306282;5110.61670374722;5111.15665915124;5184.818531351403;4868.415790105183;5014.573761230291;5023.7236951967625;5142.871428214296;5155.922661160085;3806.885793426202;3837.4435706822633;3855.20968201518;3860.9227815443674;3861.015441062525;3819.8281077351585;3848.1918797052654;3873.4577159197734;3906.882793516199;3920.4707364505853;3782.1301100746846;3810.40938654509;3822.5604055533554;3857.537095548538;3867.4778904847767;3586.659267369596;3640.7815531068222;3713.424419215026;3769.208466222097;3770.1140232045445;3195.9680403196135;3198.200449887528;3214.8231847248394;3242.01118658809;3260.902172934792;4705.6470764692785;4845.927311090337;4856.465788763233;4883.4628190898975;4987;4240.936385954183;4268.637165840876;4276.465441819772;4280.464941882265;4298.591633794785;5289.175234544115;5315.149576067811;5328.067588172094;5392.11521835816;5420.945790542083;3482.878099266539;3501.4047611906035;3527.7883327000204;3540.522029526007;3555.5022296878456;5375;5556.333240011184;5571.659902840816;5600.27196464457;5709.543236541067;3567;3596.9100772480374;3626.8730594429067;3635.9091022724115;3638.6543278388513;3640.3265395901844;3644.5079914211774;3679.4296883983025;3695.131644063643;3739.8878033659034;4273.380359847804;4275.144971005811;4324.394584758136;4332.505285676437;4390.7585082820115;5095.694258344512;5169.353830771153;5333.813316533902;5386.030514507426;5415.783368665209;1245.7072587941827;1259.8551166615773;1290.2323117744927;1292.0761655416422;1321.6497628128554;808.5997431271559;821.979450513742;832.9541875196923;837.4305472278787;842.4524059361341;5000.599952003831;5051.949480505148;5110.437851836295;5139.948600514022;5143.048536020848;5565.916511252253;5589.608727389043;5625.240592520039;5626.85932851682;5667.858303542444;5037.370328708911;5043.773030213649;5048.091343558195;5071.340725705634;5146.562542183956;2874.6837847836723;2951.7491013263684;3022.1386904732044;3033.7572994160414;3046.8781248750247;5542.667439953616;5566.165075238747;5567.777288908398;5606.775728970795;5699.800506982236;5612.102063669793;5635.323761148688;5664.660120392789;5765.423457654201;5768.567357448124;5540.113581826889;5553.250311208016;5560.805371812048;5629.7185140742795;5634.070378387521;5455.536279416294;5496.258005169251;5516.172574113915;5556.38879723222;5645.887082258414;5346.251524786455;5408.13469844823;5420.376656684532;5441.5102640762525;5468.72656367188;5433.782648694166;5500.724963751876;5537.446255374431;5568.972155139199;5587.245721827664;3554.235839294564;3577.5349204603235;3592.263585964923;3613.2592818471626;3627.6372362763514;5254.632175747661;5291.3385826771655;5413.269208656939;5478.698671573102;5538.91691624634;5292.867678308073;5295.4439783822145;5302;5355.892882142413;5423.83728488146;5371.865703357447;5376.408595054462;5414.3232095988005;5430.402655707948;5442.755076021509;5286.36563612369;5288.471152884681;5298.470152984825;5327.840164795062;5376.919346209888;5372.194170874243;5389.294820658643;5441.292631957978;5458.1266997280245;5462.890742185214;5242.030224408497;5259.868503287448;5260.605454590845;5285.841424757264;5368.731563421735 19:02:53 INFO - 2015-11-16 19:02:53,863 DEBUG : BROWSER_OUTPUT: |5;yui.html;589.7611467355721;590.937951515091;591.7662523303295;605.9666718330495;617.1637431280615;10836;11052.834207486894;11071.557137714502;11089.944550277258;11306.208565400426;10425.687229383111;10439.791204175912;10451;10525.684229473109;10664.30682005669;677.8983152527111;694.6700317349244;697.3479796390366;698.099451707297;699;695.2664938489891;705.4109818301724;705.5026206524414;715.1596873673438;721.631967696476;732.3262598409476;735.1288722863424;735.2977906099688;736.9005184300131;744.2557442557443;717.5730440387961;721.1130309719075;729.6278897762153;734.6657270941708;736.9976831509143;534.2680527677069;534.959878009147;536.6699479819882;540.5459414092143;545.18222666001;10569.260151789378;10873.238873278873;10911.945440272828;10997.505112269968;11028.503717332658;7640.235976402371;7802.570858602775;7850.882236766453;7852.803679908048;8130.186981301823;7046.6828992695455;7087.180717112362;7119.074520312326;7394.482386232966;7577.583232922187;2356.5286942611374;2464.3962229253766;2491.6511688363644;2498.1256560203965;2512.9748702512925;38247.61752382496;38520.61479385226;38787.80606096952;38821;38848.028799279964;5544.889102217933;5614.270144881221;5632.155176723524;5661.575381846378;5750.108733146369;9718.562664680107;9735.805283894424;9768.462734549668;9779.804403911881;9875.012498750068;4950.801967921243;5032.823851165192;5039.269305950616;5080.644354895122;5154.742262886841;3003.6695963444004;3086.382723455273;3098.860551275198;3182.077197612666;3256.234784825564;2051.138521820839;2067.9793202068086;2088.4361222469847;2099.548597051641;2101.3905967269625;297.72014306551773;302.5748822903824;303.2040892656776;306.2710748418749;308.5464367379948;409.65179597342615;416.51476030424215;424.9915001700011;481.8048690280442;481.95180481951525;5989.371116032841;6152.107944348134;6256;6283.7800676976085;6297.622142671455;430.7458599426354;458.81188712627664;471.1542780708636;482.5873877834471;494.2602040816378;2821.210061182872;2850.4584129015834;2927.6925922778228;3010.9397812043635;3186.633537143212;42130.36804447936;42234.36648450276;42313.78843105765;42370.364444533356;42414;37491.812540937666;37591.81204093962;37720.43419348712;37978.62021379806;39000.6099938997;37505.43741843875;37707.24585508274;38292.80853595714;38880.80559597184;39706.80146599249;6334.809955701337;6466.612003279818;6554.508411869034;6583.242927063449;6597.571157874723;27935;28465.146045618665;28608.14175574736;28655;28808.71191288144;36268;36834.8158259207;37259.44110838285;37325.44011839879;37354.06614834651;6196;6398.744050237939;6413.743450262124;6551.279359270381;6654.83362915931;8696;8829.60266788009;8843.115688431106;9166.816663666556;9735.902640973783;8243.422960392714;8490.957545212234;8819.426737262058;8875.644974200959;9056.230220431074;8068.354531637572;8170.754877353689;8272.013187555161;8289.129641387568;8677.045524992373;8144.714934977247;8619.741407757778;8626.223639872442;8732.825343493221;9004.504752238428;7208.315210055036;7218.350348468453;7295.635218239173;7503.66233519482;7890.250426209501;6291.276503202191;6659.367360100783;6708.362705542965;7261.128664560287;7305.926940730737 19:02:53 INFO - 2015-11-16 19:02:53,863 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:02:53 INFO - 2015-11-16 19:02:53,864 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:02:53 INFO - 2015-11-16 19:02:53,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,314 19:02:53 INFO - 2015-11-16 19:02:53,864 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:02:53 INFO - 2015-11-16 19:02:53,864 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729373845__endTimestamp 19:02:53 INFO - 2015-11-16 19:02:53,864 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,865 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:02:53 INFO - 2015-11-16 19:02:53,865 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:02:53 INFO - 2015-11-16 19:02:53,865 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,865 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4199.63 Median:4352.43 stddev:530.60 (12.2%) stddev-sans-first:513.89 19:02:53 INFO - 2015-11-16 19:02:53,865 DEBUG : BROWSER_OUTPUT: Values: 2436.8 2514.9 2547.4 2581.4 2584.4 4199.3 4231.8 4294.7 4297.2 4298.0 4064.8 4125.5 4150.4 4187.4 4368.4 3869.1 3905.5 3932.5 3978.4 4006.4 524.7 3836.8 3901.9 3933.7 3952.4 3821.1 3965.3 3975.3 3995.8 4000.1 3897.3 3915.5 3934.6 3963.1 4003.7 3756.5 3850.7 3871.6 3894.2 3914.7 4042.8 4127.2 4141.9 4235.7 4289.4 4466.4 4517.6 4535.1 4584.8 4638.8 4396.8 4409.2 4501.9 4542.3 4670.3 4197.3 4255.4 4304.5 4332.7 4349.3 4550.5 4609.7 4626.5 4720.1 4720.4 4302.9 4423.1 4426.2 4452.0 4467.7 4421.5 4517.9 4567.5 4573.3 4584.2 4352.4 4447.7 4462.7 4474.2 4533.2 4324.0 4444.6 4495.0 4576.9 4604.3 3460.4 3493.5 3521.6 3611.0 3635.2 3162.3 3175.5 3203.5 3253.3 3295.0 4209.3 4227.3 4265.3 4270.7 4359.0 4520.5 4537.6 4542.8 4560.3 4663.7 4067.2 4093.1 4266.1 4318.6 4351.9 3916.8 4000.3 4043.3 4047.2 4082.1 4512.9 4565.4 4615.4 4718.7 4738.9 4391.4 4547.3 4579.9 4604.6 4639.1 4549.7 4589.7 4594.7 4649.3 4704.4 4349.8 4498.7 4502.3 4574.5 4643.5 4514.7 4534.2 4563.4 4568.4 4604.8 4416.8 4446.6 4485.9 4495.0 4509.0 4112.5 4428.3 4441.7 4445.4 4533.0 4259.7 4314.7 4341.8 4402.6 4422.4 4259.4 4381.6 4445.2 4479.8 4480.2 4222.6 4229.7 4364.3 4381.1 4428.8 19:02:53 INFO - 2015-11-16 19:02:53,866 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37008.99 Median:32072.68 stddev:57739.68 (180.0%) stddev-sans-first:57836.34 19:02:53 INFO - 2015-11-16 19:02:53,868 DEBUG : BROWSER_OUTPUT: Values: 430.7 438.7 450.4 466.9 482.2 31086.0 32157.8 32350.2 32942.3 33019.3 34663.7 34827.7 35613.0 35908.8 36028.0 7277.3 7458.0 7560.8 7577.5 7601.4 7277.7 7281.3 7365.2 7371.4 7452.9 7271.1 7370.2 7408.1 7439.2 7450.9 7255.7 7310.7 7468.3 7481.3 7513.5 7303.4 7305.7 7368.2 7441.9 7504.7 32054.4 32323.5 32730.0 32923.3 33193.7 2037.8 2154.9 2196.7 2536.2 2554.8 21895.0 22110.9 22496.9 23006.2 23264.4 1880.3 1956.1 1988.2 2014.4 2025.0 193913.0 194932.0 197849.0 198479.0 199648.0 45559.0 48373.3 49578.8 49966.5 50691.7 57485.0 58409.7 58808.4 59174.4 60168.1 11459.5 11474.2 11479.9 11609.8 11624.1 9973.8 10121.4 10195.2 10203.2 10234.8 16527.3 16933.3 16949.7 17075.1 17153.3 6564.6 6687.3 6768.5 6828.7 6844.1 684.3 751.7 775.3 782.8 796.5 22715.5 23652.4 23682.4 23764.9 23862.4 810.6 837.3 854.2 867.4 957.3 11761.2 11914.0 11969.5 12070.8 12167.5 233043.0 236147.0 239033.0 241871.8 242436.0 43055.1 43380.3 43616.0 43928.8 44207.6 1108.8 1115.6 1116.5 1121.4 1126.2 22682.7 22846.8 22976.3 23194.8 23320.2 39464.0 39520.8 39589.2 39781.6 40467.8 223386.0 224704.0 224849.0 229834.0 229983.0 24529.9 33515.3 33821.5 34559.8 35003.0 35615.5 35954.6 37048.3 37509.4 37583.6 28631.3 29652.7 29964.1 30416.5 30958.5 29791.0 29949.7 29978.0 30240.0 30285.0 30226.4 31226.8 31515.0 31851.4 32091.0 24519.9 26887.5 26890.6 27209.2 27453.2 20720.5 21043.0 21100.8 21109.4 21112.2 19:02:53 INFO - 2015-11-16 19:02:53,869 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,869 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22929.22 Median:4748.03 stddev:78358.92 (1650.3%) stddev-sans-first:78560.25 19:02:53 INFO - 2015-11-16 19:02:53,870 DEBUG : BROWSER_OUTPUT: Values: 262.4 263.4 266.5 269.7 275.6 11025.7 13496.6 13647.5 13979.4 14166.6 13644.1 13748.7 14020.2 14099.2 14314.1 4146.6 4194.1 4237.2 4296.7 4382.9 3110.9 3212.6 4319.5 4749.1 4825.7 4760.5 4777.3 4783.9 4845.9 4865.2 4634.3 4708.4 4737.1 4783.9 4888.5 4062.3 4084.7 4091.9 4123.7 4170.6 17071.7 17289.3 17303.6 17383.8 17600.0 1394.2 1494.1 1570.8 1798.3 1827.7 7302.9 7310.8 7461.5 7507.4 7636.7 1224.1 1236.2 1244.7 1263.3 1302.7 46638.0 47517.5 47876.3 48264.0 48306.5 5072.5 5082.6 5084.2 5156.8 5232.5 5797.5 5828.9 5847.1 5892.0 5916.4 4267.7 4293.8 4351.3 4367.0 4408.1 4572.2 4635.1 4683.7 4710.0 4746.9 2268.3 2307.7 2311.7 2318.7 2331.3 809.4 823.5 827.7 851.6 868.5 352.5 353.5 355.3 362.0 367.3 8723.3 8988.1 9033.6 9135.8 9608.7 366.2 368.1 370.0 370.3 401.2 5000.4 5040.8 5085.2 5099.6 5125.0 462399.0 463663.0 478159.0 489089.0 499666.0 55224.9 58977.0 59142.7 60197.4 60496.4 377.8 394.2 395.7 395.8 401.4 8288.9 8505.7 8507.7 8543.0 8556.4 26018.3 26762.8 29015.4 29186.3 29447.4 35616.8 37950.6 38807.4 39233.4 39240.2 4712.5 4726.0 4845.7 4848.3 4864.9 8700.9 8808.6 9192.9 9281.8 9283.1 6810.5 7002.4 7474.2 7584.3 8002.8 7599.5 7700.7 7868.1 7906.5 7916.8 7869.6 8083.5 8090.6 8177.0 8194.1 4851.7 4858.0 4879.6 4884.0 4946.3 7837.1 8114.8 8125.2 8127.8 8159.0 19:02:53 INFO - 2015-11-16 19:02:53,870 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,870 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4227.89 Median:5439.63 stddev:2161.35 (39.7%) stddev-sans-first:2156.80 19:02:53 INFO - 2015-11-16 19:02:53,872 DEBUG : BROWSER_OUTPUT: Values: 1377.4 1397.8 1415.8 1424.8 1433.6 5518.1 5664.8 5958.3 6051.1 6236.2 5888.8 5936.1 6095.1 6163.3 6196.6 1762.8 1793.9 1807.6 1815.8 1817.2 1718.3 1741.4 1771.4 1774.2 1795.0 1742.0 1742.4 1756.2 1757.2 1757.3 1651.7 1698.8 1701.6 1728.0 1732.8 1736.3 1753.9 1757.2 1789.2 1793.8 6113.2 6113.8 6127.4 6150.8 6213.8 3540.8 3631.0 3701.8 3777.3 3787.8 2009.2 2082.6 2172.2 2243.2 2276.5 631.0 650.5 664.6 677.8 688.2 7917.5 7961.2 7962.8 8013.8 8036.5 3322.1 3332.7 3352.7 3363.7 3384.5 7004.3 7034.3 7039.4 7092.2 7194.9 3822.1 3838.8 3867.3 3880.6 3905.3 3370.1 3429.3 3521.8 3532.3 3541.5 2697.1 2713.9 2734.4 2772.5 2806.6 900.6 931.5 943.3 948.5 960.7 1006.5 1032.8 1054.7 1070.9 1083.2 5606.2 5721.2 5785.7 5836.0 5848.2 386.1 390.4 958.4 977.9 1010.8 4573.1 4580.5 4613.7 4646.9 4726.5 6713.8 6881.5 6886.3 7088.9 7439.8 6912.5 6916.3 7009.6 7117.5 7146.0 5716.0 5750.1 5758.4 5793.7 5830.0 5517.8 5586.7 5594.5 5616.3 5698.9 6385.7 6488.8 6517.8 6530.8 6571.6 6508.3 6547.2 6594.6 6677.9 6694.6 4767.4 4853.0 4902.5 4919.2 4963.0 5853.6 5906.4 5922.6 5938.3 5953.3 5381.8 5432.5 5565.7 5593.5 5599.7 5446.8 5447.0 5460.9 5473.6 5546.5 5206.9 5465.3 5566.2 5596.7 5617.3 4814.4 4825.6 4897.3 4902.6 4908.6 5140.1 5146.2 5153.7 5172.6 5239.1 19:02:53 INFO - 2015-11-16 19:02:53,872 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,872 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4424.67 Median:5141.41 stddev:1371.39 (26.7%) stddev-sans-first:1338.83 19:02:53 INFO - 2015-11-16 19:02:53,873 DEBUG : BROWSER_OUTPUT: Values: 242.5 247.2 253.5 256.9 258.2 5028.1 5099.5 5110.6 5111.2 5184.8 4868.4 5014.6 5023.7 5142.9 5155.9 3806.9 3837.4 3855.2 3860.9 3861.0 3819.8 3848.2 3873.5 3906.9 3920.5 3782.1 3810.4 3822.6 3857.5 3867.5 3586.7 3640.8 3713.4 3769.2 3770.1 3196.0 3198.2 3214.8 3242.0 3260.9 4705.6 4845.9 4856.5 4883.5 4987.0 4240.9 4268.6 4276.5 4280.5 4298.6 5289.2 5315.1 5328.1 5392.1 5420.9 3482.9 3501.4 3527.8 3540.5 3555.5 5375.0 5556.3 5571.7 5600.3 5709.5 3567.0 3596.9 3626.9 3635.9 3638.7 3640.3 3644.5 3679.4 3695.1 3739.9 4273.4 4275.1 4324.4 4332.5 4390.8 5095.7 5169.4 5333.8 5386.0 5415.8 1245.7 1259.9 1290.2 1292.1 1321.6 808.6 822.0 833.0 837.4 842.5 5000.6 5051.9 5110.4 5139.9 5143.0 5565.9 5589.6 5625.2 5626.9 5667.9 5037.4 5043.8 5048.1 5071.3 5146.6 2874.7 2951.7 3022.1 3033.8 3046.9 5542.7 5566.2 5567.8 5606.8 5699.8 5612.1 5635.3 5664.7 5765.4 5768.6 5540.1 5553.3 5560.8 5629.7 5634.1 5455.5 5496.3 5516.2 5556.4 5645.9 5346.3 5408.1 5420.4 5441.5 5468.7 5433.8 5500.7 5537.4 5569.0 5587.2 3554.2 3577.5 3592.3 3613.3 3627.6 5254.6 5291.3 5413.3 5478.7 5538.9 5292.9 5295.4 5302.0 5355.9 5423.8 5371.9 5376.4 5414.3 5430.4 5442.8 5286.4 5288.5 5298.5 5327.8 5376.9 5372.2 5389.3 5441.3 5458.1 5462.9 5242.0 5259.9 5260.6 5285.8 5368.7 19:02:53 INFO - 2015-11-16 19:02:53,874 DEBUG : BROWSER_OUTPUT: 19:02:53 INFO - 2015-11-16 19:02:53,874 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10410.25 Median:5579.58 stddev:12569.77 (225.3%) stddev-sans-first:12583.40 19:02:53 INFO - 2015-11-16 19:02:53,874 DEBUG : BROWSER_OUTPUT: Values: 589.8 590.9 591.8 606.0 617.2 10836.0 11052.8 11071.6 11089.9 11306.2 10425.7 10439.8 10451.0 10525.7 10664.3 677.9 694.7 697.3 698.1 699.0 695.3 705.4 705.5 715.2 721.6 732.3 735.1 735.3 736.9 744.3 717.6 721.1 729.6 734.7 737.0 534.3 535.0 536.7 540.5 545.2 10569.3 10873.2 10911.9 10997.5 11028.5 7640.2 7802.6 7850.9 7852.8 8130.2 7046.7 7087.2 7119.1 7394.5 7577.6 2356.5 2464.4 2491.7 2498.1 2513.0 38247.6 38520.6 38787.8 38821.0 38848.0 5544.9 5614.3 5632.2 5661.6 5750.1 9718.6 9735.8 9768.5 9779.8 9875.0 4950.8 5032.8 5039.3 5080.6 5154.7 3003.7 3086.4 3098.9 3182.1 3256.2 2051.1 2068.0 2088.4 2099.5 2101.4 297.7 302.6 303.2 306.3 308.5 409.7 416.5 425.0 481.8 482.0 5989.4 6152.1 6256.0 6283.8 6297.6 430.7 458.8 471.2 482.6 494.3 2821.2 2850.5 2927.7 3010.9 3186.6 42130.4 42234.4 42313.8 42370.4 42414.0 37491.8 37591.8 37720.4 37978.6 39000.6 37505.4 37707.2 38292.8 38880.8 39706.8 6334.8 6466.6 6554.5 6583.2 6597.6 27935.0 28465.1 28608.1 28655.0 28808.7 36268.0 36834.8 37259.4 37325.4 37354.1 6196.0 6398.7 6413.7 6551.3 6654.8 8696.0 8829.6 8843.1 9166.8 9735.9 8243.4 8491.0 8819.4 8875.6 9056.2 8068.4 8170.8 8272.0 8289.1 8677.0 8144.7 8619.7 8626.2 8732.8 9004.5 7208.3 7218.4 7295.6 7503.7 7890.3 6291.3 6659.4 6708.4 7261.1 7305.9 19:02:53 INFO - 2015-11-16 19:02:53,876 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:02:53 INFO - 2015-11-16 19:02:53,876 DEBUG : BROWSER_OUTPUT: 19:02:54 INFO - 2015-11-16 19:02:54,565 INFO : Browser exited with error code: 0 19:02:54 INFO - 2015-11-16 19:02:54,600 INFO : Completed test dromaeo_css (00:18:33) 19:02:54 INFO - 2015-11-16 19:02:54,600 INFO : Starting test kraken 19:02:54 INFO - 2015-11-16 19:02:54,600 DEBUG : operating with platform_type : mac_ 19:02:54 INFO - 2015-11-16 19:02:54,600 INFO : Initialising browser for kraken test... 19:02:54 INFO - 2015-11-16 19:02:54,616 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmp3uDGdp/profile http://localhost:49269/getInfo.html 19:02:57 INFO - 2015-11-16 19:02:57,981 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:02:57 INFO - 2015-11-16 19:02:57,981 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:02:57 INFO - 2015-11-16 19:02:57,981 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:02:57 INFO - 2015-11-16 19:02:57,981 DEBUG : BROWSER_OUTPUT: __metrics 19:02:58 INFO - 2015-11-16 19:02:58,752 INFO : Browser initialized. 19:02:58 INFO - 2015-11-16 19:02:58,752 INFO : Running cycle 1/1 for kraken test... 19:02:58 INFO - 2015-11-16 19:02:58,752 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmp3uDGdp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:03:11 INFO - 2015-11-16 19:03:11,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 241946624 19:03:11 INFO - 2015-11-16 19:03:11,086 DEBUG : BROWSER_OUTPUT: 19:03:14 INFO - 2015-11-16 19:03:14,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:14 INFO - 2015-11-16 19:03:14,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 259522560 19:03:14 INFO - 2015-11-16 19:03:14,743 DEBUG : BROWSER_OUTPUT: 19:03:17 INFO - 2015-11-16 19:03:17,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 19:03:18 INFO - 2015-11-16 19:03:18,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 267554816 19:03:18 INFO - 2015-11-16 19:03:18,541 DEBUG : BROWSER_OUTPUT: 19:03:22 INFO - 2015-11-16 19:03:22,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 19:03:22 INFO - 2015-11-16 19:03:22,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 267128832 19:03:22 INFO - 2015-11-16 19:03:22,594 DEBUG : BROWSER_OUTPUT: 19:03:24 INFO - 2015-11-16 19:03:24,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 19:03:25 INFO - 2015-11-16 19:03:25,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 267509760 19:03:25 INFO - 2015-11-16 19:03:25,466 DEBUG : BROWSER_OUTPUT: 19:03:27 INFO - 2015-11-16 19:03:27,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:03:28 INFO - 2015-11-16 19:03:28,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 268140544 19:03:28 INFO - 2015-11-16 19:03:28,556 DEBUG : BROWSER_OUTPUT: 19:03:32 INFO - 2015-11-16 19:03:32,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 19:03:32 INFO - 2015-11-16 19:03:32,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 265486336 19:03:32 INFO - 2015-11-16 19:03:32,809 DEBUG : BROWSER_OUTPUT: 19:03:36 INFO - 2015-11-16 19:03:36,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 19:03:37 INFO - 2015-11-16 19:03:37,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 265383936 19:03:37 INFO - 2015-11-16 19:03:37,246 DEBUG : BROWSER_OUTPUT: 19:03:40 INFO - 2015-11-16 19:03:40,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 19:03:41 INFO - 2015-11-16 19:03:41,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 265363456 19:03:41 INFO - 2015-11-16 19:03:41,323 DEBUG : BROWSER_OUTPUT: 19:03:43 INFO - 2015-11-16 19:03:43,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:03:43 INFO - 2015-11-16 19:03:43,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 265592832 19:03:43 INFO - 2015-11-16 19:03:43,766 DEBUG : BROWSER_OUTPUT: 19:03:45 INFO - 2015-11-16 19:03:45,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:03:46 INFO - 2015-11-16 19:03:46,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 267046912 19:03:46 INFO - 2015-11-16 19:03:46,521 DEBUG : BROWSER_OUTPUT: 19:03:49 INFO - 2015-11-16 19:03:49,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:03:49 INFO - 2015-11-16 19:03:49,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 267313152 19:03:49 INFO - 2015-11-16 19:03:49,613 DEBUG : BROWSER_OUTPUT: 19:03:52 INFO - 2015-11-16 19:03:52,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:03:53 INFO - 2015-11-16 19:03:53,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 267350016 19:03:53 INFO - 2015-11-16 19:03:53,371 DEBUG : BROWSER_OUTPUT: 19:03:56 INFO - 2015-11-16 19:03:56,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:57 INFO - 2015-11-16 19:03:57,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 268427264 19:03:57 INFO - 2015-11-16 19:03:57,164 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 19:03:59 INFO - 2015-11-16 19:03:59,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 273530880 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: |0;ai-astar;134;134;142;140;142;157;141;142;141;142 19:03:59 INFO - 2015-11-16 19:03:59,382 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;204;170;191;206;178;196;197;172;213;164 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |2;audio-dft;214;208;207;211;211;211;210;210;219;220 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;92;104;153;84;89;92;95;135;88 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;114;157;112;115;116;157;113;114;165 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;157;149;150;156;165;165;159;157;156;150 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;164;164;164;173;174;172;173;173;171;164 19:03:59 INFO - 2015-11-16 19:03:59,383 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;123;140;130;139;129;132;134;142;141;136 19:03:59 INFO - 2015-11-16 19:03:59,384 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;81;85;86;85;85;85;92;84;83 19:03:59 INFO - 2015-11-16 19:03:59,384 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;84;87;90;91;92;92;91;92;92;96 19:03:59 INFO - 2015-11-16 19:03:59,384 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;108;113;113;113;112;121;119;120;119;121 19:03:59 INFO - 2015-11-16 19:03:59,384 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;176;167;172;171;182;188;178;172;170;180 19:03:59 INFO - 2015-11-16 19:03:59,385 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;201;200;188;201;203;199;209;212;216;213 19:03:59 INFO - 2015-11-16 19:03:59,385 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;85;89;93;93;92;91;91;92;99;96 19:03:59 INFO - 2015-11-16 19:03:59,385 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:03:59 INFO - 2015-11-16 19:03:59,385 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:03:59 INFO - 2015-11-16 19:03:59,385 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 19:03:59 INFO - 2015-11-16 19:03:59,386 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:03:59 INFO - 2015-11-16 19:03:59,386 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729439379__endTimestamp 19:03:59 INFO - 2015-11-16 19:03:59,386 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,386 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:03:59 INFO - 2015-11-16 19:03:59,386 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:03:59 INFO - 2015-11-16 19:03:59,387 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,387 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:141.50 Median:142.00 stddev:6.29 (4.4%) stddev-sans-first:6.06 19:03:59 INFO - 2015-11-16 19:03:59,387 DEBUG : BROWSER_OUTPUT: Values: 134.0 134.0 142.0 140.0 142.0 157.0 141.0 142.0 141.0 142.0 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:189.10 Median:196.50 stddev:17.01 (8.7%) stddev-sans-first:17.16 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: Values: 204.0 170.0 191.0 206.0 178.0 196.0 197.0 172.0 213.0 164.0 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:212.10 Median:211.00 stddev:4.33 (2.1%) stddev-sans-first:4.54 19:03:59 INFO - 2015-11-16 19:03:59,389 DEBUG : BROWSER_OUTPUT: Values: 214.0 208.0 207.0 211.0 211.0 211.0 210.0 210.0 219.0 220.0 19:03:59 INFO - 2015-11-16 19:03:59,390 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,390 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:101.70 Median:88.50 stddev:23.38 (26.4%) stddev-sans-first:24.01 19:03:59 INFO - 2015-11-16 19:03:59,390 DEBUG : BROWSER_OUTPUT: Values: 85.0 92.0 104.0 153.0 84.0 89.0 92.0 95.0 135.0 88.0 19:03:59 INFO - 2015-11-16 19:03:59,390 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,390 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.80 Median:115.50 stddev:22.98 (19.9%) stddev-sans-first:22.98 19:03:59 INFO - 2015-11-16 19:03:59,391 DEBUG : BROWSER_OUTPUT: Values: 105.0 114.0 157.0 112.0 115.0 116.0 157.0 113.0 114.0 165.0 19:03:59 INFO - 2015-11-16 19:03:59,391 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,391 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:156.40 Median:157.00 stddev:5.70 (3.6%) stddev-sans-first:6.04 19:03:59 INFO - 2015-11-16 19:03:59,391 DEBUG : BROWSER_OUTPUT: Values: 157.0 149.0 150.0 156.0 165.0 165.0 159.0 157.0 156.0 150.0 19:03:59 INFO - 2015-11-16 19:03:59,392 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,392 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:169.20 Median:172.50 stddev:4.54 (2.6%) stddev-sans-first:4.41 19:03:59 INFO - 2015-11-16 19:03:59,392 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 173.0 174.0 172.0 173.0 173.0 171.0 164.0 19:03:59 INFO - 2015-11-16 19:03:59,392 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,392 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:134.60 Median:137.50 stddev:6.15 (4.5%) stddev-sans-first:4.88 19:03:59 INFO - 2015-11-16 19:03:59,393 DEBUG : BROWSER_OUTPUT: Values: 123.0 140.0 130.0 139.0 129.0 132.0 134.0 142.0 141.0 136.0 19:03:59 INFO - 2015-11-16 19:03:59,393 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,393 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:84.20 Median:85.00 stddev:4.02 (4.7%) stddev-sans-first:2.98 19:03:59 INFO - 2015-11-16 19:03:59,393 DEBUG : BROWSER_OUTPUT: Values: 76.0 81.0 85.0 86.0 85.0 85.0 85.0 92.0 84.0 83.0 19:03:59 INFO - 2015-11-16 19:03:59,394 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,394 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:90.70 Median:92.00 stddev:3.23 (3.5%) stddev-sans-first:2.35 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 90.0 91.0 92.0 92.0 91.0 92.0 92.0 96.0 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:115.90 Median:119.00 stddev:4.61 (3.9%) stddev-sans-first:3.90 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 113.0 113.0 112.0 121.0 119.0 120.0 119.0 121.0 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:175.60 Median:177.00 stddev:6.43 (3.6%) stddev-sans-first:6.82 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: Values: 176.0 167.0 172.0 171.0 182.0 188.0 178.0 172.0 170.0 180.0 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.20 Median:206.00 stddev:8.36 (4.1%) stddev-sans-first:8.79 19:03:59 INFO - 2015-11-16 19:03:59,396 DEBUG : BROWSER_OUTPUT: Values: 201.0 200.0 188.0 201.0 203.0 199.0 209.0 212.0 216.0 213.0 19:03:59 INFO - 2015-11-16 19:03:59,397 DEBUG : BROWSER_OUTPUT: 19:03:59 INFO - 2015-11-16 19:03:59,397 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:92.10 Median:92.50 stddev:3.75 (4.1%) stddev-sans-first:2.98 19:03:59 INFO - 2015-11-16 19:03:59,397 DEBUG : BROWSER_OUTPUT: Values: 85.0 89.0 93.0 93.0 92.0 91.0 91.0 92.0 99.0 96.0 19:03:59 INFO - 2015-11-16 19:03:59,397 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:03:59 INFO - 2015-11-16 19:03:59,397 DEBUG : BROWSER_OUTPUT: 19:04:00 INFO - 2015-11-16 19:04:00,042 INFO : Browser exited with error code: 0 19:04:00 INFO - 2015-11-16 19:04:00,099 INFO : Completed test kraken (00:01:05) 19:04:00 INFO - 2015-11-16 19:04:00,100 INFO : Starting test v8_7 19:04:00 INFO - 2015-11-16 19:04:00,100 DEBUG : operating with platform_type : mac_ 19:04:00 INFO - 2015-11-16 19:04:00,100 INFO : Initialising browser for v8_7 test... 19:04:00 INFO - 2015-11-16 19:04:00,116 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmpzV1X88/profile http://localhost:49269/getInfo.html 19:04:03 INFO - 2015-11-16 19:04:03,534 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:04:03 INFO - 2015-11-16 19:04:03,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:04:03 INFO - 2015-11-16 19:04:03,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:04:03 INFO - 2015-11-16 19:04:03,534 DEBUG : BROWSER_OUTPUT: __metrics 19:04:04 INFO - 2015-11-16 19:04:04,300 INFO : Browser initialized. 19:04:04 INFO - 2015-11-16 19:04:04,301 INFO : Running cycle 1/1 for v8_7 test... 19:04:04 INFO - 2015-11-16 19:04:04,301 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/T/tmpzV1X88/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:04:16 INFO - 2015-11-16 19:04:16,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 241631232 19:04:16 INFO - 2015-11-16 19:04:16,582 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 19:04:39 INFO - 2015-11-16 19:04:39,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 260755456 19:04:39 INFO - 2015-11-16 19:04:39,472 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,472 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:04:39 INFO - 2015-11-16 19:04:39,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:04:39 INFO - 2015-11-16 19:04:39,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:04:39 INFO - 2015-11-16 19:04:39,474 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:04:39 INFO - 2015-11-16 19:04:39,474 DEBUG : BROWSER_OUTPUT: |0;Richards;206.65426741062203 19:04:39 INFO - 2015-11-16 19:04:39,474 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;251.06703489831784 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |2;Encrypt;397.77247414478916 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7150 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1430.615164520744 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |5;Earley;961.5384615384615 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |6;Boyer;17631.57894736842 19:04:39 INFO - 2015-11-16 19:04:39,475 DEBUG : BROWSER_OUTPUT: |7;RegExp;35875 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: |8;Splay;838.3045525902669 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7185.714285714285 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: __startTimestamp1447729479471__endTimestamp 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,476 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:206.65 Median:206.65 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: Values: 206.7 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,477 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:251.07 Median:251.07 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,478 DEBUG : BROWSER_OUTPUT: Values: 251.1 19:04:39 INFO - 2015-11-16 19:04:39,478 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,478 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:397.77 Median:397.77 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,478 DEBUG : BROWSER_OUTPUT: Values: 397.8 19:04:39 INFO - 2015-11-16 19:04:39,478 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7150.00 Median:7150.00 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: Values: 7150.0 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1430.62 Median:1430.62 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: Values: 1430.6 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,479 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:961.54 Median:961.54 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,480 DEBUG : BROWSER_OUTPUT: Values: 961.5 19:04:39 INFO - 2015-11-16 19:04:39,480 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,480 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:17631.58 Median:17631.58 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,480 DEBUG : BROWSER_OUTPUT: Values: 17631.6 19:04:39 INFO - 2015-11-16 19:04:39,480 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35875.00 Median:35875.00 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: Values: 35875.0 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:838.30 Median:838.30 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: Values: 838.3 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: 19:04:39 INFO - 2015-11-16 19:04:39,482 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7185.71 Median:7185.71 stddev:0.00 (0.0%) 19:04:39 INFO - 2015-11-16 19:04:39,483 DEBUG : BROWSER_OUTPUT: Values: 7185.7 19:04:39 INFO - 2015-11-16 19:04:39,483 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:04:39 INFO - 2015-11-16 19:04:39,483 DEBUG : BROWSER_OUTPUT: 19:04:40 INFO - 2015-11-16 19:04:40,267 INFO : Browser exited with error code: 0 19:04:40 INFO - 2015-11-16 19:04:40,293 INFO : Completed test v8_7 (00:00:40) 19:04:40 INFO - 2015-11-16 19:04:40,420 INFO : Completed test suite (00:20:19) 19:04:40 INFO - 2015-11-16 19:04:40,420 DEBUG : Working with test: dromaeo_css 19:04:40 INFO - 2015-11-16 19:04:40,420 DEBUG : Generating results file: dromaeo_css 19:04:40 INFO - 2015-11-16 19:04:40,421 DEBUG : Working with test: kraken 19:04:40 INFO - 2015-11-16 19:04:40,421 DEBUG : Generating results file: kraken 19:04:40 INFO - 2015-11-16 19:04:40,421 INFO : javascript benchmark 19:04:40 INFO - 2015-11-16 19:04:40,421 DEBUG : Working with test: v8_7 19:04:40 INFO - 2015-11-16 19:04:40,421 DEBUG : Generating results file: v8_7 19:04:40 INFO - 2015-11-16 19:04:40,421 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:40 INFO - 2015-11-16 19:04:40,481 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 19:04:40 INFO - 2015-11-16 19:04:40,481 DEBUG : process_Request line: dromaeo_css 5301.57 graph.html#tests=[[72,63,57]] 19:04:40 INFO - 2015-11-16 19:04:40,481 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:40 INFO - 2015-11-16 19:04:40,512 DEBUG : process_Request line: kraken 1994.10 graph.html#tests=[[232,63,57]] 19:04:40 INFO - 2015-11-16 19:04:40,512 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:40 INFO - 2015-11-16 19:04:40,541 DEBUG : process_Request line: v8_7 15536.33 graph.html#tests=[[230,63,57]] 19:04:40 INFO - 2015-11-16 19:04:40,542 INFO : javascript benchmark 19:04:40 INFO - 2015-11-16 19:04:40,544 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [262.41874248539506, 263.3666033190177, 266.46440654284885, 269.7141030507663, 275.64992459576337, 11025.724356891082, 13496.59510214694, 13647.522336718217, 13979.370928308224, 14166.575002749922, 13644.113132646396, 13748.725025499509, 14020.158790472578, 14099.154050756935, 14314.069585476936, 4146.585341465852, 4194.077302993352, 4237.194932962742, 4296.677749168824, 4382.890427739316, 3110.9066727998197, 3212.5823642926503, 4319.50325712544, 4749.121412538691, 4825.710457372569, 4760.523947605247, 4777.307290442884, 4783.904321913559, 4845.903081938359, 4865.221564549673, 4634.281686338606, 4708.387909571768, 4737.076270127326, 4783.928241076386, 4888.535589119028, 4062.329715596923, 4084.7344922580232, 4091.85678501251, 4123.711340206187, 4170.562090980464, 17071.658566828595, 17289.30842766288, 17303.567410814703, 17383.826161738474, 17600.0, 1394.1983359568187, 1494.12593632725, 1570.8272090070084, 1798.2537247042462, 1827.6527459782599, 7302.890456643155, 7310.780676579711, 7461.477696561243, 7507.368232073144, 7636.656350464243, 1224.136983426682, 1236.2397125767588, 1244.695049712817, 1263.3051821498232, 1302.6808431934141, 46638.0, 47517.52482475166, 47876.28185577219, 48264.0, 48306.51693483091, 5072.51811077947, 5082.567981721521, 5084.186530155157, 5156.819511317086, 5232.529072383504, 5797.507211886952, 5828.941710582924, 5847.093700476433, 5892.0, 5916.408359164049, 4267.658587313008, 4293.806778694966, 4351.26028575143, 4367.039251364695, 4408.0522687622315, 4572.154151481986, 4635.096156249499, 4683.742394168354, 4710.010897711519, 4746.928796068062, 2268.3308424014626, 2307.711536057993, 2311.722593288816, 2318.652202169654, 2331.265651319829, 809.3565615335822, 823.518241828525, 827.6565225431378, 851.6040041380663, 868.5440143924491, 352.52585272808034, 353.50156279645574, 355.2965129044455, 362.0442033032796, 367.28746232309237, 8723.302135829119, 8988.10118988096, 9033.593488293043, 9135.817283654289, 9608.66369677058, 366.2473616717618, 368.1495744829399, 369.9981500092536, 370.3223101723839, 401.15356597579085, 5000.374953130859, 5040.84877453677, 5085.203138273934, 5099.554650210734, 5125.0, 462399.0, 463663.0, 478159.0, 489089.0, 499666.0, 55224.895502089734, 58977.0, 59142.70428647829, 60197.398026020055, 60496.39503604996, 377.8016541315776, 394.2469882524365, 395.72299390426815, 395.83374982507416, 401.3858796042002, 8288.88100106478, 8505.74482765518, 8507.702230421906, 8542.957285213533, 8556.358273129665, 26018.34954126162, 26762.79567419432, 29015.419691606472, 29186.270343241587, 29447.411051779272, 35616.82191589129, 37950.62049379471, 38807.41788873113, 39233.41149882697, 39240.215195696495, 4712.50518695532, 4725.976370118127, 4845.685030473008, 4848.296996935495, 4864.878378040577, 8700.869486957827, 8808.64765409402, 9192.862107068266, 9281.767955801159, 9283.071692830663, 6810.523263371517, 7002.404795592432, 7474.177840437439, 7584.2794934481135, 8002.83994320122, 7599.506032107895, 7700.691972321044, 7868.134505204537, 7906.52560846351, 7916.802079948047, 7869.606519673879, 8083.474574152661, 8090.595470226583, 8176.959115204386, 8194.098649148707, 4851.733154676526, 4858.0, 4879.56083952446, 4883.975580122076, 4946.282788995503, 7837.13791482925, 8114.797130071795, 8125.228103330174, 8127.83744325122, 8159.0], "dojo.html": [2436.7928726058285, 2514.924552263433, 2547.3631592101974, 2581.3804686875155, 2584.392667723086, 4199.286121359372, 4231.767252801099, 4294.742315461067, 4297.183535128327, 4298.011457364808, 4064.756114633117, 4125.46368972034, 4150.439690641762, 4187.413762073312, 4368.432103826506, 3869.1101046759263, 3905.453236546886, 3932.508436445444, 3978.38335058065, 4006.379011253246, 524.6781663175262, 3836.7889766062854, 3901.9024524386978, 3933.6656384207377, 3952.387379956097, 3821.14024344523, 3965.3258945978964, 3975.264576053425, 3995.7802320872343, 4000.119973605802, 3897.2984862724697, 3915.4909861717792, 3934.645881870617, 3963.147923196527, 4003.6797056235723, 3756.5116534850295, 3850.7497012694084, 3871.612838716134, 3894.1627550076587, 3914.725969182158, 4042.797860106983, 4127.215828992482, 4141.855035073788, 4235.745855248695, 4289.420928174688, 4466.441694788152, 4517.59341659249, 4535.092981403733, 4584.816607335702, 4638.79125439356, 4396.8021439035, 4409.162259170779, 4501.864944051651, 4542.318652202163, 4670.322803193552, 4197.265478541273, 4255.446791917031, 4304.504981927118, 4332.718373305725, 4349.282368409209, 4550.47669518003, 4609.677322587387, 4626.537346265414, 4720.0559888022535, 4720.362751028636, 4302.870913872589, 4423.093265880551, 4426.18115648606, 4451.998300382453, 4467.7319360838455, 4421.469423669116, 4517.932231016537, 4567.5432456754725, 4573.314002899591, 4584.174848527297, 4352.434183556117, 4447.688661793643, 4462.665300102441, 4474.172278128557, 4533.206688829442, 4324.0, 4444.622207112367, 4495.0, 4576.8626941191815, 4604.332371806069, 3460.377132116193, 3493.458513930345, 3521.57741071068, 3610.981945090258, 3635.2184280379315, 3162.335909459039, 3175.491921292582, 3203.4874420092674, 3253.3330667213163, 3295.044437113258, 4209.284421648327, 4227.281362168439, 4265.296226122655, 4270.7010509264055, 4359.04101097758, 4520.547945205453, 4537.636989040869, 4542.772861356985, 4560.338750881104, 4663.743494107789, 4067.186562687474, 4093.1199792044854, 4266.146770645883, 4318.5681431856565, 4351.934720979188, 3916.804159791999, 4000.27994960904, 4043.2924238258774, 4047.177153804675, 4082.142750022469, 4512.909741805145, 4565.360849481075, 4615.446146462446, 4718.693284936468, 4738.928916066331, 4391.407160033355, 4547.340635607752, 4579.908401832011, 4604.562566556172, 4639.095376401569, 4549.7042692224895, 4589.701669391479, 4594.7243165408845, 4649.256119020941, 4704.388429504143, 4349.8042588084245, 4498.662600305056, 4502.30270822282, 4574.4510658721165, 4643.489216186149, 4514.706544074625, 4534.161180181677, 4563.429571303587, 4568.383268258743, 4604.769761511978, 4416.801243943966, 4446.622037126751, 4485.910281794411, 4495.0, 4509.0, 4112.485939257593, 4428.31361139024, 4441.733495990251, 4445.355423463644, 4532.954670453253, 4259.659227261874, 4314.69797114199, 4341.8046187922255, 4402.625776809007, 4422.3587579800105, 4259.42497762798, 4381.605655490894, 4445.244308467633, 4479.7536135512855, 4480.238359478962, 4222.556631553643, 4229.725067870701, 4364.323529852878, 4381.058072514425, 4428.778561071998], "mootools.html": [1377.4490203918435, 1397.7623803953327, 1415.7663985442402, 1424.8361438434583, 1433.569929021294, 5518.144687573423, 5664.773409063643, 5958.314793798714, 6051.092336149574, 6236.220472440945, 5888.7644494220285, 5936.109583562467, 6095.116208149816, 6163.2912215095275, 6196.566240363177, 1762.8237176282398, 1793.865460090492, 1807.6475087357971, 1815.7639506864089, 1817.2276782367508, 1718.2525601363384, 1741.3731056819536, 1771.3977247735768, 1774.1661419133052, 1794.9948029103743, 1741.982580174201, 1742.3988723890238, 1756.2272600055999, 1757.2443849144863, 1757.3146472875526, 1651.6614094110678, 1698.8131305556378, 1701.6001239708658, 1728.0, 1732.7697334892305, 1736.3315123677348, 1753.8509226715744, 1757.156564848867, 1789.2395731814056, 1793.757842691233, 6113.23584551931, 6113.755449782004, 6127.356627554132, 6150.815475535741, 6213.782517611907, 3540.805255710935, 3630.981845090784, 3701.796401197933, 3777.338965680995, 3787.753796003251, 2009.1661960286463, 2082.6147162774937, 2172.2397160993683, 2243.2036626997506, 2276.533310671325, 630.9905351419733, 650.5088658063132, 664.6311297230036, 677.8440958579554, 688.2016860441863, 7917.485363451357, 7961.1640777718085, 7962.800929976739, 8013.759587212393, 8036.517808931424, 3322.0864262328055, 3332.683395077464, 3352.7485438591716, 3363.7140843028615, 3384.5430866833153, 7004.2645522220455, 7034.2965703429245, 7039.401650859734, 7092.184398794205, 7194.892076618855, 3822.063594419385, 3838.808059597065, 3867.284552357823, 3880.631340022693, 3905.258000979805, 3370.1237678203843, 3429.2627085176805, 3521.841517131735, 3532.346515894568, 3541.468779683068, 2697.1369161868015, 2713.8643067846924, 2734.4394399148127, 2772.459370422748, 2806.593044008607, 900.5587262241586, 931.4783721116197, 943.3302355327656, 948.5352177433008, 960.6925783749273, 1006.4766321512918, 1032.8450732390052, 1054.6941386997837, 1070.8768491623564, 1083.1659622090947, 5606.187102870061, 5721.22763426932, 5785.739641716133, 5836.007878660638, 5848.152017957457, 386.08690447092425, 390.41242929391086, 958.3770549143113, 977.8973207813219, 1010.757418219622, 4573.108243892476, 4580.519045500241, 4613.746243956548, 4646.86059418218, 4726.456457507362, 6713.765018224339, 6881.483888708367, 6886.345797149263, 7088.858222835617, 7439.8140046499275, 6912.481563882729, 6916.273791251846, 7009.61447120403, 7117.501774875709, 7145.96427017872, 5716.0, 5750.051241545182, 5758.395368486249, 5793.681347525927, 5830.038043722739, 5517.806876759294, 5586.692731899622, 5594.496495315441, 5616.297962754656, 5698.886022279614, 6385.680715964276, 6488.837779055561, 6517.771877984437, 6530.836729081621, 6571.605703657796, 6508.284088750139, 6547.181602299713, 6594.571352862049, 6677.866442671217, 6694.631795251308, 4767.356406885026, 4852.95147048525, 4902.534259245366, 4919.2129259318335, 4963.0, 5853.619514731528, 5906.438888305604, 5922.615030023035, 5938.317093534126, 5953.28560572734, 5381.811636592701, 5432.511074003359, 5565.749541270571, 5593.524550413261, 5599.692016939108, 5446.754896029609, 5447.0, 5460.863478413072, 5473.616846820684, 5546.473085056913, 5206.921896171485, 5465.344158700822, 5566.248556444828, 5596.720163991866, 5617.297837770278, 4814.422269327703, 4825.638077144298, 4897.338859254098, 4902.63230257725, 4908.63185261114, 5140.12617854973, 5146.176611742103, 5153.7165455898785, 5172.612054095883, 5239.135542635575], "ext.html": [430.7178797887383, 438.6994908487686, 450.4189595421905, 466.88327918020485, 482.1658530741819, 31086.0, 32157.83921080391, 32350.19124521885, 32942.34115317695, 33019.339613207725, 34663.65336346636, 34827.651723482755, 35613.0, 35908.82045589769, 36028.0, 7277.3086556777025, 7457.993170921937, 7560.773176804677, 7577.507462014979, 7601.391888648895, 7277.708891644328, 7281.308275713799, 7365.189829118819, 7371.37343325818, 7452.925470745305, 7271.127464704243, 7370.226126256746, 7408.148062972747, 7439.181690014094, 7450.888236676454, 7255.673494692725, 7310.671019804122, 7468.290512401313, 7481.289277518627, 7513.549187048768, 7303.415726741901, 7305.707771689126, 7368.226336234672, 7441.925580744178, 7504.662290196954, 32054.358912821845, 32323.51514727281, 32730.018099457055, 32923.3415331692, 33193.6680633193, 2037.7860324665844, 2154.8707077575395, 2196.690082152643, 2536.1884197056947, 2554.846709197454, 21895.0, 22110.88944555283, 22496.88751556248, 23006.194783182676, 23264.418389540228, 1880.2854915132161, 1956.1099699636632, 1988.1848442138653, 2014.3654748754095, 2025.0077462043494, 193913.0, 194932.0, 197849.0, 198479.0, 199648.0, 45559.0, 48373.274400884016, 49578.75210623996, 49966.500334996184, 50691.74654126706, 57485.0, 58409.70795146082, 58808.41191588029, 59174.40825591775, 60168.09747853786, 11459.541618335174, 11474.196806223485, 11479.942600286946, 11609.76780464386, 11624.070074394029, 9973.750656233653, 10121.39271643689, 10195.184385249162, 10203.234757393226, 10234.795304093876, 16527.33890644361, 16933.322667093424, 16949.661006779796, 17075.146242688064, 17153.313867445413, 6564.6389448580785, 6687.297833727389, 6768.458523318122, 6828.692708828015, 6844.076049733222, 684.3293572299175, 751.7256201486418, 775.3215936055951, 782.7573452229827, 796.4902462424053, 22715.545689086124, 23652.408689782893, 23682.4079398013, 23764.88117559401, 23862.403439914142, 810.6068556749972, 837.2757564706607, 854.2354592639678, 867.4101610904519, 957.2772556719632, 11761.235519691192, 11914.0, 11969.46137423818, 12070.758584828254, 12167.452464639113, 233043.0, 236147.0, 239033.0, 241871.79064104566, 242436.0, 43055.13889722188, 43380.34929476061, 43616.0, 43928.78035609866, 44207.55792442099, 1108.844761733358, 1115.5816568786704, 1116.4696769034645, 1121.360824330124, 1126.1947707389256, 22682.65976010328, 22846.771532284463, 22976.310710678707, 23194.768052319934, 23320.183793567143, 39464.0, 39520.802395987834, 39589.2082158361, 39781.60218397779, 40467.79766101151, 223386.0, 224704.0, 224849.0, 229834.0, 229983.0, 24529.877350613133, 33515.329693406486, 33821.49267760936, 34559.82720086384, 35003.0, 35615.46576801298, 35954.64045359618, 37048.25903481969, 37509.4373584391, 37583.62416375801, 28631.284217894718, 29652.70347296586, 29964.101076966854, 30416.543751844183, 30958.53562196614, 29791.0, 29949.700502994692, 29978.0, 30240.0, 30285.0, 30226.395472089996, 31226.843865780527, 31515.0, 31851.36297274088, 32091.0, 24519.877400613597, 26887.462250754485, 26890.596641050008, 27209.183724488295, 27453.17640470789, 20720.481987949817, 21043.00091491306, 21100.788992110498, 21109.41140006172, 21112.15551377928], "prototype.html": [242.46294457776023, 247.20153902893665, 253.45886532253644, 256.9145360850407, 258.20730357801557, 5028.0698070856915, 5099.541041306282, 5110.61670374722, 5111.15665915124, 5184.818531351403, 4868.415790105183, 5014.573761230291, 5023.7236951967625, 5142.871428214296, 5155.922661160085, 3806.885793426202, 3837.4435706822633, 3855.20968201518, 3860.9227815443674, 3861.015441062525, 3819.8281077351585, 3848.1918797052654, 3873.4577159197734, 3906.882793516199, 3920.4707364505853, 3782.1301100746846, 3810.40938654509, 3822.5604055533554, 3857.537095548538, 3867.4778904847767, 3586.659267369596, 3640.7815531068222, 3713.424419215026, 3769.208466222097, 3770.1140232045445, 3195.9680403196135, 3198.200449887528, 3214.8231847248394, 3242.01118658809, 3260.902172934792, 4705.6470764692785, 4845.927311090337, 4856.465788763233, 4883.4628190898975, 4987.0, 4240.936385954183, 4268.637165840876, 4276.465441819772, 4280.464941882265, 4298.591633794785, 5289.175234544115, 5315.149576067811, 5328.067588172094, 5392.11521835816, 5420.945790542083, 3482.878099266539, 3501.4047611906035, 3527.7883327000204, 3540.522029526007, 3555.5022296878456, 5375.0, 5556.333240011184, 5571.659902840816, 5600.27196464457, 5709.543236541067, 3567.0, 3596.9100772480374, 3626.8730594429067, 3635.9091022724115, 3638.6543278388513, 3640.3265395901844, 3644.5079914211774, 3679.4296883983025, 3695.131644063643, 3739.8878033659034, 4273.380359847804, 4275.144971005811, 4324.394584758136, 4332.505285676437, 4390.7585082820115, 5095.694258344512, 5169.353830771153, 5333.813316533902, 5386.030514507426, 5415.783368665209, 1245.7072587941827, 1259.8551166615773, 1290.2323117744927, 1292.0761655416422, 1321.6497628128554, 808.5997431271559, 821.979450513742, 832.9541875196923, 837.4305472278787, 842.4524059361341, 5000.599952003831, 5051.949480505148, 5110.437851836295, 5139.948600514022, 5143.048536020848, 5565.916511252253, 5589.608727389043, 5625.240592520039, 5626.85932851682, 5667.858303542444, 5037.370328708911, 5043.773030213649, 5048.091343558195, 5071.340725705634, 5146.562542183956, 2874.6837847836723, 2951.7491013263684, 3022.1386904732044, 3033.7572994160414, 3046.8781248750247, 5542.667439953616, 5566.165075238747, 5567.777288908398, 5606.775728970795, 5699.800506982236, 5612.102063669793, 5635.323761148688, 5664.660120392789, 5765.423457654201, 5768.567357448124, 5540.113581826889, 5553.250311208016, 5560.805371812048, 5629.7185140742795, 5634.070378387521, 5455.536279416294, 5496.258005169251, 5516.172574113915, 5556.38879723222, 5645.887082258414, 5346.251524786455, 5408.13469844823, 5420.376656684532, 5441.5102640762525, 5468.72656367188, 5433.782648694166, 5500.724963751876, 5537.446255374431, 5568.972155139199, 5587.245721827664, 3554.235839294564, 3577.5349204603235, 3592.263585964923, 3613.2592818471626, 3627.6372362763514, 5254.632175747661, 5291.3385826771655, 5413.269208656939, 5478.698671573102, 5538.91691624634, 5292.867678308073, 5295.4439783822145, 5302.0, 5355.892882142413, 5423.83728488146, 5371.865703357447, 5376.408595054462, 5414.3232095988005, 5430.402655707948, 5442.755076021509, 5286.36563612369, 5288.471152884681, 5298.470152984825, 5327.840164795062, 5376.919346209888, 5372.194170874243, 5389.294820658643, 5441.292631957978, 5458.1266997280245, 5462.890742185214, 5242.030224408497, 5259.868503287448, 5260.605454590845, 5285.841424757264, 5368.731563421735], "yui.html": [589.7611467355721, 590.937951515091, 591.7662523303295, 605.9666718330495, 617.1637431280615, 10836.0, 11052.834207486894, 11071.557137714502, 11089.944550277258, 11306.208565400426, 10425.687229383111, 10439.791204175912, 10451.0, 10525.684229473109, 10664.30682005669, 677.8983152527111, 694.6700317349244, 697.3479796390366, 698.099451707297, 699.0, 695.2664938489891, 705.4109818301724, 705.5026206524414, 715.1596873673438, 721.631967696476, 732.3262598409476, 735.1288722863424, 735.2977906099688, 736.9005184300131, 744.2557442557443, 717.5730440387961, 721.1130309719075, 729.6278897762153, 734.6657270941708, 736.9976831509143, 534.2680527677069, 534.959878009147, 536.6699479819882, 540.5459414092143, 545.18222666001, 10569.260151789378, 10873.238873278873, 10911.945440272828, 10997.505112269968, 11028.503717332658, 7640.235976402371, 7802.570858602775, 7850.882236766453, 7852.803679908048, 8130.186981301823, 7046.6828992695455, 7087.180717112362, 7119.074520312326, 7394.482386232966, 7577.583232922187, 2356.5286942611374, 2464.3962229253766, 2491.6511688363644, 2498.1256560203965, 2512.9748702512925, 38247.61752382496, 38520.61479385226, 38787.80606096952, 38821.0, 38848.028799279964, 5544.889102217933, 5614.270144881221, 5632.155176723524, 5661.575381846378, 5750.108733146369, 9718.562664680107, 9735.805283894424, 9768.462734549668, 9779.804403911881, 9875.012498750068, 4950.801967921243, 5032.823851165192, 5039.269305950616, 5080.644354895122, 5154.742262886841, 3003.6695963444004, 3086.382723455273, 3098.860551275198, 3182.077197612666, 3256.234784825564, 2051.138521820839, 2067.9793202068086, 2088.4361222469847, 2099.548597051641, 2101.3905967269625, 297.72014306551773, 302.5748822903824, 303.2040892656776, 306.2710748418749, 308.5464367379948, 409.65179597342615, 416.51476030424215, 424.9915001700011, 481.8048690280442, 481.95180481951525, 5989.371116032841, 6152.107944348134, 6256.0, 6283.7800676976085, 6297.622142671455, 430.7458599426354, 458.81188712627664, 471.1542780708636, 482.5873877834471, 494.2602040816378, 2821.210061182872, 2850.4584129015834, 2927.6925922778228, 3010.9397812043635, 3186.633537143212, 42130.36804447936, 42234.36648450276, 42313.78843105765, 42370.364444533356, 42414.0, 37491.812540937666, 37591.81204093962, 37720.43419348712, 37978.62021379806, 39000.6099938997, 37505.43741843875, 37707.24585508274, 38292.80853595714, 38880.80559597184, 39706.80146599249, 6334.809955701337, 6466.612003279818, 6554.508411869034, 6583.242927063449, 6597.571157874723, 27935.0, 28465.146045618665, 28608.14175574736, 28655.0, 28808.71191288144, 36268.0, 36834.8158259207, 37259.44110838285, 37325.44011839879, 37354.06614834651, 6196.0, 6398.744050237939, 6413.743450262124, 6551.279359270381, 6654.83362915931, 8696.0, 8829.60266788009, 8843.115688431106, 9166.816663666556, 9735.902640973783, 8243.422960392714, 8490.957545212234, 8819.426737262058, 8875.644974200959, 9056.230220431074, 8068.354531637572, 8170.754877353689, 8272.013187555161, 8289.129641387568, 8677.045524992373, 8144.714934977247, 8619.741407757778, 8626.223639872442, 8732.825343493221, 9004.504752238428, 7208.315210055036, 7218.350348468453, 7295.635218239173, 7503.66233519482, 7890.250426209501, 6291.276503202191, 6659.367360100783, 6708.362705542965, 7261.128664560287, 7305.926940730737]}, "summary": {"lowerIsBetter": false, "suite": 5301.569487438157, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5540.999837008909, "unit": "ms", "value": 5540.999837008909}, "dojo.html": {"lowerIsBetter": false, "filtered": 4168.646837333265, "unit": "ms", "value": 4168.646837333265}, "mootools.html": {"lowerIsBetter": false, "filtered": 3477.091624567943, "unit": "ms", "value": 3477.091624567943}, "ext.html": {"lowerIsBetter": false, "filtered": 15046.26649101806, "unit": "ms", "value": 15046.26649101806}, "prototype.html": {"lowerIsBetter": false, "filtered": 3962.2280291711227, "unit": "ms", "value": 3962.2280291711227}, "yui.html": {"lowerIsBetter": false, "filtered": 4636.722273068402, "unit": "ms", "value": 4636.722273068402}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0040.e"}, "testrun": {"date": 1447728261, "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": "20151116163503", "branch": "Mozilla-Inbound", "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2"}}, {"talos_counters": {}, "results": {"audio-dft": [214.0, 208.0, 207.0, 211.0, 211.0, 211.0, 210.0, 210.0, 219.0, 220.0], "ai-astar": [134.0, 134.0, 142.0, 140.0, 142.0, 157.0, 141.0, 142.0, 141.0, 142.0], "imaging-gaussian-blur": [157.0, 149.0, 150.0, 156.0, 165.0, 165.0, 159.0, 157.0, 156.0, 150.0], "audio-beat-detection": [204.0, 170.0, 191.0, 206.0, 178.0, 196.0, 197.0, 172.0, 213.0, 164.0], "json-stringify-tinderbox": [84.0, 87.0, 90.0, 91.0, 92.0, 92.0, 91.0, 92.0, 92.0, 96.0], "stanford-crypto-pbkdf2": [201.0, 200.0, 188.0, 201.0, 203.0, 199.0, 209.0, 212.0, 216.0, 213.0], "json-parse-financial": [76.0, 81.0, 85.0, 86.0, 85.0, 85.0, 85.0, 92.0, 84.0, 83.0], "stanford-crypto-sha256-iterative": [85.0, 89.0, 93.0, 93.0, 92.0, 91.0, 91.0, 92.0, 99.0, 96.0], "audio-fft": [85.0, 92.0, 104.0, 153.0, 84.0, 89.0, 92.0, 95.0, 135.0, 88.0], "imaging-darkroom": [164.0, 164.0, 164.0, 173.0, 174.0, 172.0, 173.0, 173.0, 171.0, 164.0], "stanford-crypto-ccm": [176.0, 167.0, 172.0, 171.0, 182.0, 188.0, 178.0, 172.0, 170.0, 180.0], "audio-oscillator": [105.0, 114.0, 157.0, 112.0, 115.0, 116.0, 157.0, 113.0, 114.0, 165.0], "stanford-crypto-aes": [108.0, 113.0, 113.0, 113.0, 112.0, 121.0, 119.0, 120.0, 119.0, 121.0], "imaging-desaturate": [123.0, 140.0, 130.0, 139.0, 129.0, 132.0, 134.0, 142.0, 141.0, 136.0]}, "summary": {"lowerIsBetter": true, "suite": 1994.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 101.7, "unit": "ms", "value": 101.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 204.2, "unit": "ms", "value": 204.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 189.1, "unit": "ms", "value": 189.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 175.6, "unit": "ms", "value": 175.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 169.2, "unit": "ms", "value": 169.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 84.2, "unit": "ms", "value": 84.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 126.8, "unit": "ms", "value": 126.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 141.5, "unit": "ms", "value": 141.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 212.1, "unit": "ms", "value": 212.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 92.1, "unit": "ms", "value": 92.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 90.7, "unit": "ms", "value": 90.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 156.4, "unit": "ms", "value": 156.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 115.9, "unit": "ms", "value": 115.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 134.6, "unit": "ms", "value": 134.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0040.e"}, "testrun": {"date": 1447728261, "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": "20151116163503", "branch": "Mozilla-Inbound", "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [251.06703489831784], "Encrypt": [397.77247414478916], "NavierStokes": [7185.714285714285], "Decrypt": [7150.0], "Splay": [838.3045525902669], "Richards": [206.65426741062203], "RegExp": [35875.0], "Earley": [961.5384615384615], "Boyer": [17631.57894736842], "RayTrace": [1430.615164520744]}, "summary": {"lowerIsBetter": false, "suite": 15536.334452103378, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 263.3479939999999, "unit": "score", "value": 263.3479939999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 669.1790340000001, "unit": "score", "value": 669.1790340000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 206.52087475149108, "unit": "score", "value": 206.52087475149108}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.228111888111876, "unit": "score", "value": 37.228111888111876}, "Splay": {"lowerIsBetter": false, "filtered": 97.20930149812735, "unit": "score", "value": 97.20930149812735}, "RegExp": {"lowerIsBetter": false, "filtered": 25.393310104529636, "unit": "score", "value": 25.393310104529636}, "Richards": {"lowerIsBetter": false, "filtered": 170.82637800000003, "unit": "score", "value": 170.82637800000003}, "Earley": {"lowerIsBetter": false, "filtered": 693.1215199999998, "unit": "score", "value": 693.1215199999998}, "Boyer": {"lowerIsBetter": false, "filtered": 37.799394029850745, "unit": "score", "value": 37.799394029850745}, "RayTrace": {"lowerIsBetter": false, "filtered": 517.2523110000001, "unit": "score", "value": 517.2523110000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0040.e"}, "testrun": {"date": 1447728261, "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": "20151116163503", "branch": "Mozilla-Inbound", "revision": "1ec80d27792a10df33e1f1635b7dad14b3f1f8e2"}}] 19:04:40 INFO - RETURN: dromaeo_css: 5301.57 19:04:40 INFO - RETURN: kraken: 1994.10 19:04:40 INFO - RETURN: v8_7: 15536.33 19:04:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "15536.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1994.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5301.57"}}} 19:04:40 INFO - Return code: 0 19:04:40 INFO - # TBPL SUCCESS # 19:04:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:04:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:04:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:04:40 INFO - 2015-11-16 19:04:40.654 screenresolution[1659:10543] starting screenresolution argv=screenresolution get 19:04:40 INFO - 2015-11-16 19:04:40.658 screenresolution[1659:10543] Display 0: 1600x1200x32@60 19:04:40 INFO - 2015-11-16 19:04:40.665 screenresolution[1660:10546] starting screenresolution argv=screenresolution list 19:04:40 INFO - Available Modes on Display 0 19:04:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:04:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:04:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:04:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:04:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:04:40 INFO - Intel HD Graphics 3000: 19:04:40 INFO - Chipset Model: Intel HD Graphics 3000 19:04:40 INFO - Type: GPU 19:04:40 INFO - Bus: Built-In 19:04:40 INFO - VRAM (Total): 512 MB 19:04:40 INFO - VRAM (Dynamic, Max): 10 19:04:40 INFO - Vendor: Intel (0x8086) 19:04:40 INFO - Device ID: 0x0116 19:04:40 INFO - Revision ID: 0x0009 19:04:40 INFO - Displays: 19:04:40 INFO - Display: 19:04:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:04:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:04:40 INFO - Display Serial Number: 1600x1200 60 19:04:40 INFO - Main Display: Yes 19:04:40 INFO - Mirror: Off 19:04:40 INFO - Online: Yes 19:04:40 INFO - Rotation: Supported 19:04:40 INFO - Return code: 0 19:04:40 INFO - Running post-action listener: _resource_record_post_action 19:04:40 INFO - Running post-run listener: _resource_record_post_run 19:04:42 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 40595456; Write bytes: 692513792; Read time: 5049; Write time: 56959 19:04:42 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 339300864; Write bytes: 335050752; Read time: 38988; Write time: 8262 19:04:42 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 39489536; Write bytes: 347091968; Read time: 4718; Write time: 47888 19:04:42 INFO - Running post-run listener: _upload_blobber_files 19:04:42 INFO - Blob upload gear active. 19:04:42 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:04:42 INFO - Copying logs to upload dir... 19:04:42 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1356.493905 ========= master_lag: 93.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 10 secs) (at 2015-11-16 19:06:15.944502) ========= ========= Started set props: build_url (results: 0, elapsed: 5 secs) (at 2015-11-16 19:06:15.945648) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010906 build_url: 'https://queue.taskcluster.net/v1/task/OuN5zbMKSHe6IkC7i-ZAkg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 5.97 ========= ========= Finished set props: build_url (results: 0, elapsed: 5 secs) (at 2015-11-16 19:06:21.927676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-16 19:06:21.928093) ========= 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.mbRYssd0QQ/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.pF3ievJXKi/Listeners TMPDIR=/var/folders/_z/78cjndc50fnb34chkk5mynfm00000w/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.005807 ========= master_lag: 5.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2015-11-16 19:06:27.118069) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2015-11-16 19:06:27.118337) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2015-11-16 19:06:33.973393) ========= ========= Total master_lag: 110.47 =========