builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0099 starttime: 1447262260.69 results: success (0) buildid: 20151111073129 builduid: b072c0c496f54fb3b46c53402a74ff53 revision: e402ff476e1b9ff5764aeec44442ab3213c2efc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.685410) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.685903) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.686236) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.006137 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.755073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.755458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.780402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.780804) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.012439 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.830378) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.833793) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.834242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:40.834690) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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-11 09:17:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-11 09:17:41 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:41.045909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:41.046268) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.103711 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:41.165341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 09:17:41.165849) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e402ff476e1b9ff5764aeec44442ab3213c2efc6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e402ff476e1b9ff5764aeec44442ab3213c2efc6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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-11 09:17:41,258 truncating revision to first 12 chars 2015-11-11 09:17:41,258 Setting DEBUG logging. 2015-11-11 09:17:41,258 attempt 1/10 2015-11-11 09:17:41,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e402ff476e1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 09:17:42,320 unpacking tar archive at: fx-team-e402ff476e1b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353636 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 09:17:42.583013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:42.583358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:42.601684) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:42.602066) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 09:17:42.602522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 36 mins, 40 secs) (at 2015-11-11 09:17:42.602864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:17:42 INFO - MultiFileLogger online at 20151111 09:17:42 in /builds/slave/test 09:17:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:17:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:42 INFO - {'append_to_log': False, 09:17:42 INFO - 'base_work_dir': '/builds/slave/test', 09:17:42 INFO - 'blob_upload_branch': 'Fx-Team', 09:17:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:42 INFO - 'branch': 'Fx-Team', 09:17:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:42 INFO - 'config_files': ('talos/mac_config.py',), 09:17:42 INFO - 'default_actions': ('clobber', 09:17:42 INFO - 'read-buildbot-config', 09:17:42 INFO - 'download-and-extract', 09:17:42 INFO - 'populate-webroot', 09:17:42 INFO - 'create-virtualenv', 09:17:42 INFO - 'install', 09:17:42 INFO - 'run-tests'), 09:17:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:42 INFO - 'download_minidump_stackwalk': True, 09:17:42 INFO - 'download_symbols': 'ondemand', 09:17:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:42 INFO - 'installer_path': 'installer.exe', 09:17:42 INFO - 'log_level': 'info', 09:17:42 INFO - 'log_name': 'talos', 09:17:42 INFO - 'log_to_console': True, 09:17:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:42 INFO - 'opt_config_files': (), 09:17:42 INFO - 'pip_index': False, 09:17:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:42 INFO - 'cmd': ('bash', 09:17:42 INFO - '-c', 09:17:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:42 INFO - 'enabled': True, 09:17:42 INFO - 'halt_on_failure': False, 09:17:42 INFO - 'name': 'check_screen_resolution'},), 09:17:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:42 INFO - 'cmd': ('bash', 09:17:42 INFO - '-c', 09:17:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:42 INFO - 'enabled': True, 09:17:42 INFO - 'halt_on_failure': False, 09:17:42 INFO - 'name': 'check_screen_resolution'},), 09:17:42 INFO - 'run_cmd_checks_enabled': True, 09:17:42 INFO - 'sps_profile': False, 09:17:42 INFO - 'sps_profile_interval': 0, 09:17:42 INFO - 'suite': 'dromaeojs-e10s', 09:17:42 INFO - 'system_bits': '64', 09:17:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:42 INFO - 'title': 't-yosemite-r5-0099', 09:17:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:42 INFO - 'use_talos_json': True, 09:17:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:42 INFO - 'work_dir': 'build'} 09:17:42 INFO - ##### 09:17:42 INFO - ##### Running clobber step. 09:17:42 INFO - ##### 09:17:42 INFO - Running pre-action listener: _resource_record_pre_action 09:17:42 INFO - Running main action method: clobber 09:17:42 INFO - rmtree: /builds/slave/test/build 09:17:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:46 INFO - Running post-action listener: _resource_record_post_action 09:17:46 INFO - ##### 09:17:46 INFO - ##### Running read-buildbot-config step. 09:17:46 INFO - ##### 09:17:46 INFO - Running pre-action listener: _resource_record_pre_action 09:17:46 INFO - Running main action method: read_buildbot_config 09:17:46 INFO - Using buildbot properties: 09:17:46 INFO - { 09:17:46 INFO - "properties": { 09:17:46 INFO - "buildnumber": 39, 09:17:46 INFO - "product": "firefox", 09:17:46 INFO - "script_repo_revision": "production", 09:17:46 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 09:17:46 INFO - "repository": "", 09:17:46 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 09:17:46 INFO - "buildid": "20151111073129", 09:17:46 INFO - "slavename": "t-yosemite-r5-0099", 09:17:46 INFO - "pgo_build": "False", 09:17:46 INFO - "basedir": "/builds/slave/test", 09:17:46 INFO - "project": "", 09:17:46 INFO - "platform": "yosemite", 09:17:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:17:46 INFO - "slavebuilddir": "test", 09:17:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:17:46 INFO - "branch": "fx-team", 09:17:46 INFO - "repo_path": "integration/fx-team", 09:17:46 INFO - "stage_platform": "macosx64", 09:17:46 INFO - "builduid": "b072c0c496f54fb3b46c53402a74ff53", 09:17:46 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:17:46 INFO - }, 09:17:46 INFO - "sourcestamp": { 09:17:46 INFO - "repository": "", 09:17:46 INFO - "hasPatch": false, 09:17:46 INFO - "project": "", 09:17:46 INFO - "branch": "fx-team-macosx64-talos", 09:17:46 INFO - "changes": [ 09:17:46 INFO - { 09:17:46 INFO - "category": null, 09:17:46 INFO - "files": [ 09:17:46 INFO - { 09:17:46 INFO - "url": null, 09:17:46 INFO - "name": "https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:17:46 INFO - } 09:17:46 INFO - ], 09:17:46 INFO - "repository": "", 09:17:46 INFO - "rev": "e402ff476e1b9ff5764aeec44442ab3213c2efc6", 09:17:46 INFO - "who": "cbook@mozilla.com", 09:17:46 INFO - "when": 1447261653, 09:17:46 INFO - "number": 6649191, 09:17:46 INFO - "comments": "Bug 1152255 - Removed Telemetry.asyncFetchTelemetryData call in TelemetryController.jsm. r=Dexter", 09:17:46 INFO - "project": "", 09:17:46 INFO - "at": "Wed 11 Nov 2015 09:07:33", 09:17:46 INFO - "branch": "fx-team-macosx64-talos", 09:17:46 INFO - "revlink": "", 09:17:46 INFO - "properties": [ 09:17:46 INFO - [ 09:17:46 INFO - "buildid", 09:17:46 INFO - "20151111073129", 09:17:46 INFO - "Change" 09:17:46 INFO - ], 09:17:46 INFO - [ 09:17:46 INFO - "builduid", 09:17:46 INFO - "b072c0c496f54fb3b46c53402a74ff53", 09:17:46 INFO - "Change" 09:17:46 INFO - ], 09:17:46 INFO - [ 09:17:46 INFO - "pgo_build", 09:17:46 INFO - "False", 09:17:46 INFO - "Change" 09:17:46 INFO - ] 09:17:46 INFO - ], 09:17:46 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:17:46 INFO - } 09:17:46 INFO - ], 09:17:46 INFO - "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6" 09:17:46 INFO - } 09:17:46 INFO - } 09:17:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:17:46 INFO - Running post-action listener: _resource_record_post_action 09:17:46 INFO - ##### 09:17:46 INFO - ##### Running download-and-extract step. 09:17:46 INFO - ##### 09:17:46 INFO - Running pre-action listener: _resource_record_pre_action 09:17:46 INFO - Running main action method: download_and_extract 09:17:46 INFO - mkdir: /builds/slave/test/build/tests 09:17:46 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')]} 09:17:46 INFO - https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:17:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/test_packages.json 09:17:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/test_packages.json 09:17:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:17:48 INFO - Downloaded 1149 bytes. 09:17:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:17:48 INFO - Using the following test package requirements: 09:17:48 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:17:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'jsshell-mac.zip'], 09:17:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:17:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:17:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:17:48 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:17:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:17:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:17:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:17:48 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:48 INFO - https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:17:50 INFO - Downloaded 17454010 bytes. 09:17:50 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 09:17:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:17:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:17:55 INFO - Return code: 0 09:17:55 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 09:17:55 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')]} 09:17:55 INFO - https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:17:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:17:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:17:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:24:45 INFO - Downloaded 17454010 bytes. 09:24:45 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 09:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:24:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:24:50 INFO - Return code: 0 09:24:50 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')]} 09:24:50 INFO - https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:30:28 INFO - Downloaded 11131693 bytes. 09:30:28 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 09:30:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:30:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:30:28 INFO - Return code: 0 09:30: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')]} 09:30:28 INFO - https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/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 09:32:44 INFO - Downloaded 108707481 bytes. 09:32:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:32:44 INFO - mkdir: /builds/slave/test/properties 09:32:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:44 INFO - Contents: 09:32:44 INFO - build_url:https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:32:44 INFO - Running post-action listener: _resource_record_post_action 09:32:44 INFO - Running post-action listener: set_extra_try_arguments 09:32:44 INFO - ##### 09:32:44 INFO - ##### Running populate-webroot step. 09:32:44 INFO - ##### 09:32:44 INFO - Running pre-action listener: _resource_record_pre_action 09:32:44 INFO - Running main action method: populate_webroot 09:32:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:32:44 INFO - '../fennec_ids.txt'], 09:32:44 INFO - 'tests': ['tcheck2']}, 09:32:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:44 INFO - '--tppagecycles', 09:32:44 INFO - '7'], 09:32:44 INFO - 'tests': ['tsvgm']}}, 09:32:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:32:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:32:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:32:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'tests': ['damp', 'tps']}, 09:32:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['damp', 'tps']}, 09:32:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:32:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:44 INFO - 'other': {'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'other_l64': {'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'other_nol64': {'tests': ['a11yr', 09:32:44 INFO - 'ts_paint', 09:32:44 INFO - 'tpaint', 09:32:44 INFO - 'sessionrestore', 09:32:44 INFO - 'sessionrestore_no_auto_restore']}, 09:32:44 INFO - 'svgr': {'tests': ['tsvgx', 09:32:44 INFO - 'tsvgr_opacity', 09:32:44 INFO - 'tart', 09:32:44 INFO - 'tscrollx', 09:32:44 INFO - 'cart']}, 09:32:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['tsvgx', 09:32:44 INFO - 'tsvgr_opacity', 09:32:44 INFO - 'tart', 09:32:44 INFO - 'tscrollx', 09:32:44 INFO - 'cart']}, 09:32:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'tests': ['tp5o']}, 09:32:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'talos_options': ['--e10s'], 09:32:44 INFO - 'tests': ['tp5o']}, 09:32:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'talos_options': ['--xperf_path', 09:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:44 INFO - 'tests': ['tp5n']}, 09:32:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:32:44 INFO - 'talos_options': ['--e10s', 09:32:44 INFO - '--xperf_path', 09:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:44 INFO - 'tests': ['tp5n']}}, 09:32:44 INFO - 'talos.zip': {'path': '', 09:32:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:44 INFO - Running post-action listener: _resource_record_post_action 09:32:44 INFO - ##### 09:32:44 INFO - ##### Running create-virtualenv step. 09:32:44 INFO - ##### 09:32:44 INFO - Running pre-action listener: _resource_record_pre_action 09:32:44 INFO - Running main action method: create_virtualenv 09:32:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:44 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 09:32:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:45 INFO - Using real prefix '/tools/python27' 09:32:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:49 INFO - Installing pip.................done. 09:32:49 INFO - Return code: 0 09:32:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:49 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')]} 09:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:49 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')]} 09:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:49 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:32:49 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 09:32:49 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 09:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:49 INFO - 'HOME': '/Users/cltbld', 09:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:49 INFO - 'LOGNAME': 'cltbld', 09:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:49 INFO - 'MOZ_NO_REMOTE': '1', 09:32:49 INFO - 'NO_EM_RESTART': '1', 09:32:49 INFO - 'PAGER': '/bin/cat', 09:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:49 INFO - 'PWD': '/builds/slave/test', 09:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:49 INFO - 'SHELL': '/bin/bash', 09:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:32:49 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:49 INFO - 'USER': 'cltbld', 09:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:49 INFO - 'XPC_FLAGS': '0x0', 09:32:49 INFO - 'XPC_SERVICE_NAME': '0', 09:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 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 09:32:51 INFO - Cleaning up... 09:32:51 INFO - Return code: 0 09:32:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:51 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:32:51 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 09:32:51 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 09:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:51 INFO - 'HOME': '/Users/cltbld', 09:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:51 INFO - 'LOGNAME': 'cltbld', 09:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:51 INFO - 'MOZ_NO_REMOTE': '1', 09:32:51 INFO - 'NO_EM_RESTART': '1', 09:32:51 INFO - 'PAGER': '/bin/cat', 09:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:51 INFO - 'PWD': '/builds/slave/test', 09:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:51 INFO - 'SHELL': '/bin/bash', 09:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:32:51 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:51 INFO - 'USER': 'cltbld', 09:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:51 INFO - 'XPC_FLAGS': '0x0', 09:32:51 INFO - 'XPC_SERVICE_NAME': '0', 09:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Downloading/unpacking psutil>=0.7.1 09:32:51 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 09:32:51 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 09:32:51 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 09:32:51 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 09:32:51 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 09:32:51 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 09:32:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:32:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:54 INFO - Installing collected packages: psutil 09:32:54 INFO - Running setup.py install for psutil 09:32:54 INFO - building 'psutil._psutil_osx' extension 09:32:54 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 09:32:56 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 09:32:56 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 09:32:56 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 09:32:56 INFO - building 'psutil._psutil_posix' extension 09:32:56 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 09:32:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:32:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:32:56 INFO - ^ 09:32:56 INFO - 1 warning generated. 09:32:56 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 09:32:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:57 INFO - Successfully installed psutil 09:32:57 INFO - Cleaning up... 09:32:57 INFO - Return code: 0 09:32:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:32:57 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')]} 09:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:57 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')]} 09:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:57 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:32:57 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 09:32:57 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 09:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:57 INFO - 'HOME': '/Users/cltbld', 09:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:57 INFO - 'LOGNAME': 'cltbld', 09:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:57 INFO - 'MOZ_NO_REMOTE': '1', 09:32:57 INFO - 'NO_EM_RESTART': '1', 09:32:57 INFO - 'PAGER': '/bin/cat', 09:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:57 INFO - 'PWD': '/builds/slave/test', 09:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:57 INFO - 'SHELL': '/bin/bash', 09:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:32:57 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:57 INFO - 'USER': 'cltbld', 09:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:57 INFO - 'XPC_FLAGS': '0x0', 09:32:57 INFO - 'XPC_SERVICE_NAME': '0', 09:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:32:57 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 09:32:57 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 09:32:57 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 09:32:57 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 09:32:57 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 09:32:57 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 09:33:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:33:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:33:00 INFO - Installing collected packages: mozsystemmonitor 09:33:00 INFO - Running setup.py install for mozsystemmonitor 09:33:00 INFO - Successfully installed mozsystemmonitor 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:00 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:00 INFO - 'HOME': '/Users/cltbld', 09:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PAGER': '/bin/cat', 09:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:33:00 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - 'XPC_FLAGS': '0x0', 09:33:00 INFO - 'XPC_SERVICE_NAME': '0', 09:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:00 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 09:33:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:03 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 09:33:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:04 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 09:33:04 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 09:33:04 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 09:33:04 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 09:33:04 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 09:33:04 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 09:33:05 INFO - Downloading docopt-0.6.1.tar.gz 09:33:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:05 INFO - Running setup.py install for blobuploader 09:33:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:05 INFO - Running setup.py install for requests 09:33:06 INFO - Running setup.py install for docopt 09:33:06 INFO - Successfully installed blobuploader requests docopt 09:33:06 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:06 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:33:06 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 09:33:06 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 09:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:06 INFO - 'HOME': '/Users/cltbld', 09:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:06 INFO - 'LOGNAME': 'cltbld', 09:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:06 INFO - 'MOZ_NO_REMOTE': '1', 09:33:06 INFO - 'NO_EM_RESTART': '1', 09:33:06 INFO - 'PAGER': '/bin/cat', 09:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:06 INFO - 'PWD': '/builds/slave/test', 09:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:06 INFO - 'SHELL': '/bin/bash', 09:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:33:06 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:06 INFO - 'USER': 'cltbld', 09:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:06 INFO - 'XPC_FLAGS': '0x0', 09:33:06 INFO - 'XPC_SERVICE_NAME': '0', 09:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:06 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-3VtSOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:06 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-_rxUML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:06 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-JKCan1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-kk6ys6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-d0MAP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-MMbaxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-uSI40R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-BqRRA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-GY8WEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:07 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-KSAzjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-pB1ppo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-as1c1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-5rAAGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-0nHTzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-mhZC_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-PuWd29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:08 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-DibcRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:08 INFO - Running setup.py install for manifestparser 09:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:09 INFO - Running setup.py install for mozcrash 09:33:09 INFO - Running setup.py install for mozdebug 09:33:09 INFO - Running setup.py install for mozdevice 09:33:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:33:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:09 INFO - Running setup.py install for mozfile 09:33:09 INFO - Running setup.py install for mozhttpd 09:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozinfo 09:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozInstall 09:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozleak 09:33:10 INFO - Running setup.py install for mozlog 09:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for moznetwork 09:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozprocess 09:33:11 INFO - Running setup.py install for mozprofile 09:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozrunner 09:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozscreenshot 09:33:11 INFO - Running setup.py install for moztest 09:33:12 INFO - Running setup.py install for mozversion 09:33:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:12 INFO - Cleaning up... 09:33:12 INFO - Return code: 0 09:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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', '-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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:33:12 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 09:33:12 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 09:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:12 INFO - 'HOME': '/Users/cltbld', 09:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:12 INFO - 'LOGNAME': 'cltbld', 09:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:12 INFO - 'MOZ_NO_REMOTE': '1', 09:33:12 INFO - 'NO_EM_RESTART': '1', 09:33:12 INFO - 'PAGER': '/bin/cat', 09:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:12 INFO - 'PWD': '/builds/slave/test', 09:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:12 INFO - 'SHELL': '/bin/bash', 09:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:33:12 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:12 INFO - 'USER': 'cltbld', 09:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:12 INFO - 'XPC_FLAGS': '0x0', 09:33:12 INFO - 'XPC_SERVICE_NAME': '0', 09:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:12 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-aSWs0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:12 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-cW8pzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:12 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-jngejh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-8Bd68Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-zCBj6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-qyCx8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-kvD2Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-rSi_Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-AnXPhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:13 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-lFXqeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-bf8i5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-3EE8J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-kyHVXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-RmXS4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-0UNVWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-Iq6Zab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:14 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)) 09:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:14 INFO - Running setup.py (path:/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/pip-XTactZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:15 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 09:33:17 INFO - Downloading blessings-1.5.1.tar.gz 09:33:17 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 09:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:17 INFO - Installing collected packages: blessings 09:33:17 INFO - Running setup.py install for blessings 09:33:18 INFO - Successfully installed blessings 09:33:18 INFO - Cleaning up... 09:33:18 INFO - Return code: 0 09:33:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:18 INFO - Reading from file tmpfile_stdout 09:33:18 INFO - Current package versions: 09:33:18 INFO - blessings == 1.5.1 09:33:18 INFO - blobuploader == 1.2.4 09:33:18 INFO - docopt == 0.6.1 09:33:18 INFO - manifestparser == 1.1 09:33:18 INFO - mozInstall == 1.12 09:33:18 INFO - mozcrash == 0.16 09:33:18 INFO - mozdebug == 0.1 09:33:18 INFO - mozdevice == 0.47 09:33:18 INFO - mozfile == 1.2 09:33:18 INFO - mozhttpd == 0.7 09:33:18 INFO - mozinfo == 0.9 09:33:18 INFO - mozleak == 0.1 09:33:18 INFO - mozlog == 3.0 09:33:18 INFO - moznetwork == 0.27 09:33:18 INFO - mozprocess == 0.22 09:33:18 INFO - mozprofile == 0.27 09:33:18 INFO - mozrunner == 6.11 09:33:18 INFO - mozscreenshot == 0.1 09:33:18 INFO - mozsystemmonitor == 0.0 09:33:18 INFO - moztest == 0.7 09:33:18 INFO - mozversion == 1.4 09:33:18 INFO - psutil == 3.1.1 09:33:18 INFO - requests == 1.2.3 09:33:18 INFO - wsgiref == 0.1.2 09:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:18 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 0x10c102490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0df228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5e1f02d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, '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.9LfSd22sUx/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.WqGqRFGh6i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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 09:33:18 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 09:33:18 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 09:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:18 INFO - 'HOME': '/Users/cltbld', 09:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:18 INFO - 'LOGNAME': 'cltbld', 09:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:18 INFO - 'MOZ_NO_REMOTE': '1', 09:33:18 INFO - 'NO_EM_RESTART': '1', 09:33:18 INFO - 'PAGER': '/bin/cat', 09:33:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:18 INFO - 'PWD': '/builds/slave/test', 09:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:18 INFO - 'SHELL': '/bin/bash', 09:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:33:18 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:18 INFO - 'USER': 'cltbld', 09:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:18 INFO - 'XPC_FLAGS': '0x0', 09:33:18 INFO - 'XPC_SERVICE_NAME': '0', 09:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 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)) 09:33:18 INFO - Cleaning up... 09:33:18 INFO - Return code: 0 09:33:18 INFO - Running post-action listener: _resource_record_post_action 09:33:18 INFO - Running post-action listener: _start_resource_monitoring 09:33:18 INFO - Starting resource monitoring. 09:33:18 INFO - ##### 09:33:18 INFO - ##### Running install step. 09:33:18 INFO - ##### 09:33:18 INFO - Running pre-action listener: _resource_record_pre_action 09:33:18 INFO - Running main action method: install 09:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:19 INFO - Reading from file tmpfile_stdout 09:33:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:19 INFO - Reading from file tmpfile_stdout 09:33:19 INFO - Output received: 09:33:19 INFO - Usage: mozinstall [options] installer 09:33:19 INFO - Options: 09:33:19 INFO - -h, --help show this help message and exit 09:33:19 INFO - -d DEST, --destination=DEST 09:33:19 INFO - Directory to install application into. [default: 09:33:19 INFO - "/builds/slave/test"] 09:33:19 INFO - --app=APP Application being installed. [default: firefox] 09:33:19 INFO - mkdir: /builds/slave/test/build/application 09:33:19 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'] 09:33:19 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 09:34:01 INFO - Reading from file tmpfile_stdout 09:34:01 INFO - Output received: 09:34:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:34:01 INFO - Running post-action listener: _resource_record_post_action 09:34:01 INFO - ##### 09:34:01 INFO - ##### Running run-tests step. 09:34:01 INFO - ##### 09:34:01 INFO - Running pre-action listener: _resource_record_pre_action 09:34:01 INFO - Running main action method: run_tests 09:34:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:01 INFO - 2015-11-11 09:34:01.531 screenresolution[1633:8175] starting screenresolution argv=screenresolution get 09:34:01 INFO - 2015-11-11 09:34:01.535 screenresolution[1633:8175] Display 0: 1600x1200x32@60 09:34:01 INFO - 2015-11-11 09:34:01.542 screenresolution[1634:8177] starting screenresolution argv=screenresolution list 09:34:01 INFO - Available Modes on Display 0 09:34:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:01 INFO - Intel HD Graphics 3000: 09:34:01 INFO - Chipset Model: Intel HD Graphics 3000 09:34:01 INFO - Type: GPU 09:34:01 INFO - Bus: Built-In 09:34:01 INFO - VRAM (Total): 512 MB 09:34:01 INFO - VRAM (Dynamic, Max): 10 09:34:01 INFO - Vendor: Intel (0x8086) 09:34:01 INFO - Device ID: 0x0116 09:34:01 INFO - Revision ID: 0x0009 09:34:01 INFO - Displays: 09:34:01 INFO - Display: 09:34:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:01 INFO - Display Serial Number: 1600x1200 60 09:34:01 INFO - Main Display: Yes 09:34:01 INFO - Mirror: Off 09:34:01 INFO - Online: Yes 09:34:01 INFO - Rotation: Supported 09:34:01 INFO - Return code: 0 09:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:01 INFO - Python 2.7.3 09:34:01 INFO - Return code: 0 09:34:01 INFO - grabbing minidump binary from tooltool 09:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:34:01 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 0x10c0259f0>, '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 0x10bd85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0198c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:01 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 09:34:01 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 09:34:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:01 INFO - Return code: 0 09:34:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:34:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:34:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0099', '--webServer', 'localhost'] in /builds/slave/test/build 09:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0099 --webServer localhost 09:34:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9LfSd22sUx/Render', 09:34:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:01 INFO - 'HOME': '/Users/cltbld', 09:34:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:01 INFO - 'LOGNAME': 'cltbld', 09:34:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:01 INFO - 'MOZ_NO_REMOTE': '1', 09:34:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:01 INFO - 'NO_EM_RESTART': '1', 09:34:01 INFO - 'PAGER': '/bin/cat', 09:34:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:01 INFO - 'PWD': '/builds/slave/test', 09:34:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:01 INFO - 'SHELL': '/bin/bash', 09:34:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WqGqRFGh6i/Listeners', 09:34:01 INFO - 'TMPDIR': '/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/', 09:34:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:01 INFO - 'USER': 'cltbld', 09:34:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:01 INFO - 'XPC_FLAGS': '0x0', 09:34:01 INFO - 'XPC_SERVICE_NAME': '0', 09:34:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 09:34:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0099', '--webServer', 'localhost'] with output_timeout 3600 09:34:02 INFO - mozversion INFO | application_buildid: 20151111073129 09:34:02 INFO - mozversion INFO | application_changeset: e402ff476e1b9ff5764aeec44442ab3213c2efc6 09:34:02 INFO - mozversion INFO | application_display_name: Nightly 09:34:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:02 INFO - mozversion INFO | application_name: Firefox 09:34:02 INFO - mozversion INFO | application_remotingname: firefox 09:34:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:34:02 INFO - mozversion INFO | application_vendor: Mozilla 09:34:02 INFO - mozversion INFO | application_version: 45.0a1 09:34:02 INFO - mozversion INFO | platform_buildid: 20151111073129 09:34:02 INFO - mozversion INFO | platform_changeset: e402ff476e1b9ff5764aeec44442ab3213c2efc6 09:34:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:34:02 INFO - mozversion INFO | platform_version: 45.0a1 09:34:02 INFO - 2015-11-11 09:34:02,300 DEBUG : using testdate: 1447263242 09:34:02 INFO - 2015-11-11 09:34:02,301 DEBUG : actual date: 1447263242 09:34:02 INFO - 2015-11-11 09:34:02,311 INFO : starting webserver on 'localhost:49266' 09:34:02 INFO - 2015-11-11 09:34:02,312 INFO : Starting test suite t-yosemite-r5-0099.e 09:34:02 INFO - 2015-11-11 09:34:02,312 INFO : Starting test dromaeo_css 09:34:02 INFO - 2015-11-11 09:34:02,312 DEBUG : operating with platform_type : mac_ 09:34:02 INFO - 2015-11-11 09:34:02,313 INFO : Initialising browser for dromaeo_css test... 09:34:02 INFO - 2015-11-11 09:34:02,345 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpOOsowA/profile http://localhost:49266/getInfo.html 09:34:07 INFO - 2015-11-11 09:34:07,431 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:34:07 INFO - 2015-11-11 09:34:07,431 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:34:07 INFO - 2015-11-11 09:34:07,432 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:34:07 INFO - 2015-11-11 09:34:07,433 DEBUG : BROWSER_OUTPUT: __metrics 09:34:08 INFO - 2015-11-11 09:34:08,148 INFO : Browser initialized. 09:34:08 INFO - 2015-11-11 09:34:08,149 INFO : Running cycle 1/1 for dromaeo_css test... 09:34:08 INFO - 2015-11-11 09:34:08,149 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpOOsowA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:34:20 INFO - 2015-11-11 09:34:20,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 241311744 09:34:20 INFO - 2015-11-11 09:34:20,571 DEBUG : BROWSER_OUTPUT: 09:35:10 INFO - 2015-11-11 09:35:10,459 DEBUG : BROWSER_OUTPUT: 1447263310454 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] 09:37:21 INFO - 2015-11-11 09:37:21,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 09:37:22 INFO - 2015-11-11 09:37:22,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 266924032 09:37:22 INFO - 2015-11-11 09:37:22,775 DEBUG : BROWSER_OUTPUT: 09:40:24 INFO - 2015-11-11 09:40:24,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 09:40:25 INFO - 2015-11-11 09:40:25,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 273358848 09:40:25 INFO - 2015-11-11 09:40:25,509 DEBUG : BROWSER_OUTPUT: 09:43:27 INFO - 2015-11-11 09:43:27,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 09:43:27 INFO - 2015-11-11 09:43:27,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 274251776 09:43:27 INFO - 2015-11-11 09:43:27,907 DEBUG : BROWSER_OUTPUT: 09:46:29 INFO - 2015-11-11 09:46:29,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 09:46:30 INFO - 2015-11-11 09:46:30,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 278573056 09:46:30 INFO - 2015-11-11 09:46:30,299 DEBUG : BROWSER_OUTPUT: 09:49:33 INFO - 2015-11-11 09:49:33,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 09:49:33 INFO - 2015-11-11 09:49:33,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 284770304 09:49:33 INFO - 2015-11-11 09:49:33,823 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 09:52:36 INFO - 2015-11-11 09:52:36,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 288403456 09:52:36 INFO - 2015-11-11 09:52:36,268 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,268 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:52:36 INFO - 2015-11-11 09:52:36,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:52:36 INFO - 2015-11-11 09:52:36,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:52:36 INFO - 2015-11-11 09:52:36,269 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:52:36 INFO - 2015-11-11 09:52:36,269 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2618.5941179117235;2648.854313012784;2666.2401215653545;2710.390162213502;2721.687005994311;4576.794044268012;4621.514740952198;4639.884002899929;4649.325847752074;4673.953260467394;4441.600255976961;4472.731636101837;4524.411826462555;4563.543645635435;4641.25739881619;4212.810423530948;4226.577342265764;4289.571042895701;4311.892202694927;4372.956270437303;549.287320920814;4144.917101657965;4276.679249056333;4289.335153051282;4361.411209486726;4113.8971525711795;4176.644985176264;4188.162367526476;4195.832166713328;4246.639035681956;4237.110206856533;4257.87226383209;4268.210381079479;4269.082147338306;4317.309230523101;4028.9798551007057;4172.91654166918;4218.978905105455;4243.702940794145;4279.079997800488;4368.628666563346;4456.6880318377725;4563.589276965055;4619.030003699228;4637.234856248749;4772.594329481998;4876.195427754416;4906.975465122688;4928.964917367357;4957.132501812169;4739.028499157665;4813.951860481386;4898.044881248158;4907.969326441452;4947.90104197914;4336.544662810359;4507.909841803178;4583.770811459447;4622.14490319292;4715.292706094045;5062.949370506321;5064.41759197697;5068.467810879878;5078.187490001582;5151.201563757623;4647.442306923191;4760.166970780099;4774;4801.18379875422;4822.083804077214;4869.220924652039;4882.462929077798;4913.140200464904;4928.827491037797;4965.32968049316;4845.127876982177;4853;4868.9756551217015;4903.411590609078;4922.507749225048;4818.036392721399;4825;4845.951540484621;4861.173600487855;4921.975390123098;3878.3212937735784;3886.9611303887164;3898.8830335089992;3923.862664806718;3944.4280579315837;3349.6650334966794;3516.507688923553;3540.7698499597445;3546.3261980223674;3622.5290712207243;4566.97716511422;4569.725816450957;4588.655850811136;4607.216773148572;4660.39414876064;4975.90048199034;4980.701157930535;5027.4721154279005;5053.67151135175;5078.898422031612;4542.432195975503;4680.063987202505;4724.480307166209;4732.5977291929885;4732.95267047332;4231.724937879089;4295.935560966588;4301.913961720748;4330.198913201005;4354.129174165179;5084.56781173597;5128.358955130609;5143.1334333579825;5165.302684137593;5198.194279886624;4803.735794531334;4915.926261106015;4969.229769385751;5008.874778130576;5094.312267843942;5103.693778373309;5108.744562771921;5128.410232823124;5156.381234251914;5182.818601348935;4842.4673285939225;4905.1416002200185;4917.877053073702;4961.355023846877;4980.925286120639;4721.881952951204;4765.7140571565815;4856.854294371175;4893.339399181207;5029.145045342374;4761.095391875532;4807.7836497357;4818.10864989978;4819.6867203631655;4852.539008794159;4733.408323959505;4808.3989501312335;4832.8791780205775;4852.17513022794;4898.706077635354;4445.644348452181;4565.680402371802;4582.473015603248;4602.746848923208;4784.47370789206;4800.951990480051;4809.182438985311;4823.469418364048;4823.758812059453;4891.73095479752;4500.954990450054;4719.622430205507;4732.787024583971;4757.334182087687;4819.421669399694 09:52:36 INFO - 2015-11-11 09:52:36,269 DEBUG : BROWSER_OUTPUT: |1;ext.html;442.7808234923711;467.3433825475207;476.81165939453916;477.5749582871244;499.32591002147126;32910.50634240486;33329.66670333296;33454.33091338178;33571.832140839295;33772.4934125988;34805.65194348056;35492.645073549254;35532.64467355326;35609.82195089021;35646.82176589113;7741.574213418274;7798.8440231195345;7837.725679601215;7838;7848.48984815988;7363.447741419388;7703.8844417333785;7740.651670674833;7751.6124193790365;7779.572123533203;7593.164751877289;7613.619319034054;7687.461877668566;7718.305352518272;7752.496087754306;7626.885596716026;7715.074191097048;7761.534307941542;7780.766577002699;8000.399970002273;7506.62466876654;7629.8855517167285;7645.503042302233;7655.043119610049;7657.885131723028;32243.6775632243;32422.83788581042;32675.183120422178;32906;33418.3316333672;2153.12798316682;2327.3483424641126;2338.68932447212;2601.609758536216;3206.214477453039;22290.665640015413;22649.433764155863;23066.884665576734;23437.88281058601;23564.64653030206;1843.7142242952364;1856.545146439131;1894.0719047666682;1905.8284754372035;1932.9710054349196;199466;200359;201678;202412;205127;44614.77692611516;46480.3027954581;47716.5228347719;52556.21165682518;55214;50912.49087509078;51984.740076300135;51990.740046300285;52513.73743131336;52822.47177528252;12829.23024618526;13018;13046.608601741962;13099.607011789662;13166.078374513692;9837.311388202757;9922.355046921926;9955;9955.751106222258;9990.750231244132;16400.75398869018;16570.83429165693;16599.917000415164;16607.83392166063;16617.252223649964;6535.8692826143215;6818.249992500821;6820.6930688119155;6876.415504682058;6888.104546408935;785.654312102673;818.0938413496658;829.5354601423222;833.0336809301182;916.4409710076848;23678.28965131049;23955.401114971915;24070.157544485857;24071.51856962886;24278.27165185047;880.823835232956;923.7736754495191;984.6159997600798;985.9605615775432;1032.2774058159318;12396.566120185751;12437.62687119388;12510.437030333656;12565.560205392767;12624.431900564314;251729;254394;259968;260815;261799;44317;44350.89122771956;44386.778066109466;44822.10355792866;44919;1146.4095990564865;1149.5459293579156;1160.2632328471482;1171.5957994491887;1172.8709841917382;23290.417739555967;23649.52700945937;23680;23732.406689832893;23834.284971450885;41333.1733365325;42511.57488425076;42526;42920.141597167254;43247.13505729931;154907;156689;158240;158318.20840895723;158549;24122.03511859506;34860.82569587136;35183.12042198863;35781;36311.09222269359;36973;37122;38032.429513556766;38155;38340.808295959454;29791.85104074466;31351.372972539964;31355;31637.209069772518;31699;30955.535666964563;31224;31311.68688313088;31381.05856824299;31554.84222578964;31183.688163118077;32259.838700806347;32371.51442728314;32586.34827303488;32604.836975815917;25154.496910062062;27313.86343068272;28077.298067548476;28132.57801132944;28286.57570136491;20725.481862953548;22100.33698989033;22191.667124992815;22239.110435582395;22682.773172268728 09:52:36 INFO - 2015-11-11 09:52:36,269 DEBUG : BROWSER_OUTPUT: |2;jquery.html;274.07363112679144;277.4326502302791;279.1096402476101;282.3196097405253;284.81771666133676;11216;14164.575062748121;14271.857281427196;14339.426422943083;14871.702565948675;9654.613815447374;9782.706518804447;9790.706278811629;9791.069848364394;14814.851851481482;3595.1731101846462;3644.1071937375314;3758.2483503299313;3768.5100936878166;3795.6773674237725;3737.794421306827;3738.3457894868425;3752.8311225994757;3757.3988161894104;3767.284215998965;3704.1480459494333;3712.777233365993;3717.3494638438165;3718.3492888744495;3741.3452645787015;3692.6861216796606;3695.815209239527;3722.553293604771;3732.1789206374556;3846.788426636534;3356.2448449099;3376.7805092668896;3381.1040074380307;3400.996705971744;3416.8120753358558;10787.67636970892;11101.333919964827;11182.552697892075;11187.384693841836;11217;1495.5588101509973;1512.629405795576;1559.2593518078936;1601.7116918954584;1651.2156725555385;7952.3638108951145;8050.476719013245;8165.265126138676;8172.305354044914;8176.01887773471;1236.4806781151938;1280.2510531339178;1305.9151155174884;1329.9800502992464;1390.4994202087241;47824.521754782356;48702.26946595804;48803.51196488025;50032.74983625095;50077;5330.520253177233;5392.946070539245;5418.485243901823;5438.972805135949;5459.317585301837;6134.018557030854;6194.163787888668;6199.659018753921;6232.844178895473;6268.216472940882;4490.2142125127975;4493.393391892118;4512;4548.340490628841;4556.225441674923;4515.841945531891;4659.813607455664;4720.976395118002;4724.622030237572;4794.664373493892;2439.646251293588;2482.4042229865063;2482.689663792026;2506.5738824399896;2506.7994560435486;883.1565854608833;888.1873086126122;892.1836519584638;898.7034278688018;938.9201917836924;323.369429612257;327.2293748222948;338.78656446438583;341.6862164975665;347.45623099848655;8337.249647531751;8675.045744968049;8685.305175585938;8820.25027872638;8850.20348168668;346.28492163681915;353.2528701795735;353.35865404291644;356.61485595556735;380.4616467698231;4587.266037433995;4865.9026819463415;5209.166533354645;5322.561364360796;5542.501174894279;399758;406974;409629;411680;456726;58802;59178.70410648005;59485.75399583068;60265;61467.69266153641;412.77916314771454;432.0796703022542;435.4382846128522;435.47742708749627;437.9189849877783;8993.111446596287;9065.90934090677;9072.95463522678;9189.218916392181;9222.584983675884;27950.58074128849;28286.575701364083;28297.717022830333;29175;29180.10329328587;30891.845540772152;38826.80586597162;39418.605813941496;40100.598994009684;40539.797301014485;5060.443351231435;5071;5201.973990130176;5207.401148867777;5224.712640804641;9571.521423928636;9753.60985560598;9834.114929656365;9855.852162217716;9882.308238423242;7812.960935195288;8288.336933045463;8316.6673333066;8425.915740842513;8505.74482765518;8120.22857828529;8187.959060204661;8217.096119426978;8360.790980225544;8469.449485783405;8123.959380203298;8483.406161568631;8653.307735381028;8676.132386761527;8801.075887032026;5127.307813445286;5149.510796474329;5198.714070726146;5201.895962080813;5218.530332269962;8419.452735572168;8574.571271436278;8711.346649001223;8728.825423491622;8795.384323097322 09:52:36 INFO - 2015-11-11 09:52:36,273 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.249796358948;1474.5281509916824;1481.207553958632;1482.6664000599867;1489.8063251777266;5954.940450595493;5985.850353741148;6612.86774264515;6952.756653517122;6989.755358562451;6540.215174179093;6570.540062195648;6703.966480167593;6729.25978142404;6772.593644381341;1798.1548672124113;1869.8597605179598;1875.1561797191318;1879.2483006797322;1882.3599976008154;1850.704506845207;1866.272153859989;1871.0644677661169;1893.3278686066456;1894.0529735132434;1865.7387965684816;1889.8771579847335;1891.8675692701515;1909.5035290824346;1915.2626238898056;1826.835584797368;1862.5622978600086;1867.794542600313;1889.8488120950292;1897.8576606754411;1843.6681397348473;1845.0866820923595;1862.9161687724086;1882.8305452509203;1887.4620733091003;6573.1783527059115;6756.155480564929;6757.898631520531;6783.186017677861;6786.660666966632;3857.4792403025795;4081.4898137732785;4091.693123015756;4119.526254480743;4127.731697439657;2106.3470324199548;2172.989559854675;2389;2426.065964603623;2479.1323036937106;696.8257935516122;698.671624336561;702.80523110712;706.4948561778302;716.6739133694157;8144.714934977247;8149.633266503021;8171.877421838677;8216.83566328676;8251.587420628945;3594.946075808865;3622.601513833476;3661.5240018797917;3686.5207523021836;3750.1937083527173;7820.765377038698;7874.645640946172;7880.881786773203;7893.368530517545;7960.40296977729;4147.149834284025;4150.481189851269;4157.023099571598;4163.791810409528;4175.123224122968;3743.3636281832155;3763.6800871925643;3777.7355585109326;3786.962130378716;3791.658750712449;3026.3493348930087;3033.772467064935;3055.4958431858495;3077.2460747117098;3093.474109401407;937.681188395935;938.0385105267155;973.4500007495742;1004.1916257412706;1004.8794144702537;1001.67946257197;1007.189212683782;1056.9524371403306;1104.9834252486219;1105.1159072741775;6290.968545157245;6292;6342.746290148342;6356.14192084072;6402.775902843471;374.32994939059324;378.56843198753444;378.9905252368713;379.63554987212035;383.5646541175786;4866.31871537985;4952.331435256195;5001.474845141281;5013.147764879979;5016.799328026838;7090.645467726593;7892.289693927574;7995.360371170293;8024.438289319808;8077.919220807834;7858.371330293563;7859.331956783623;7960.243776841191;7961.044674638964;8012.879806802903;6041.607295525777;6228.968855155696;6274.435300822856;6326.398992095744;6413.005984072476;6323.683815809283;6355.269144048493;6383.7127329271225;6391.041343798467;6419;6608.339166083353;6951.826204344932;6973.860522789617;7114.608696521741;7128.607926564089;7098.396636285767;7264.927350726425;7283.927160728324;7311.963440182765;7359.668814903235;5886.028805247086;6015.548833837567;6026.728797204224;6028.216331876828;6053.697315134314;6445.323241059621;6492.577982431127;6493.935060649333;6498;6521.445677117308;5918.408159184047;6110.633361998294;6113.327533971348;6137.938620613737;6236.064590311308;5754.108113242454;5841.795537156179;5904.763809447746;5974.2233509643465;6002;6049.727762250621;6058.969705151446;6113.5414843886;6139.84650383744;6163.38366163398;5158.587313015025;5207.140821764367;5207.765650545659;5253.343332083489;5308.946910530845;5420.7289635518855;5489.34127904654;5493.615446918678;5507.449255074461;5556.111022236423 09:52:36 INFO - 2015-11-11 09:52:36,274 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.09576959489766;262.8370410345586;266.79590113563114;270.0655731170151;272.72727272727275;5151.381834179894;5179.378474583055;5193.662411943225;5211.739413029348;5222.738863056851;4989.875253118674;5124.6925184488955;5144.17693169093;5165.81919632813;5172.120739474289;3942.467766851467;3957.347037738784;3966.1671049079728;3983.302921988655;3993.4409182714444;3951.308521008826;3961.0493481564363;3962.6235507626875;3971.86098486553;3977.2642061218767;3928.41073838925;3929.3713005919058;3930.7248492605386;3931.6658084062747;3958;3775.3959366501367;3830.8467661293516;3858.5176852893387;3883.9611603884023;3899.5320561532512;3299.0597679661423;3302.2734998300334;3315.469524876008;3343.498475228711;3355.429576971896;4868.172410690191;4943.4809345018975;4972.328735620681;4976.776045077981;5019.799208031674;4373.759443230621;4383.912321753547;4416.24923762961;4423.1153769246275;4451.532589078132;5380.542653874425;5380.923815236968;5409.810656626999;5432.29380180574;5457.645253058538;3596.1189508570305;3617.149969757105;3619.5475565554307;3643.635636436362;3649.379605467077;5544.861378465571;5629.296337957755;5649.265595472603;5672.432756724335;5705.2012718219485;3674.3018826422895;3676.17286110623;3689.8339574719203;3689.9262014759556;3726.832292546842;3743.12036671382;3758.605346438639;3766.5668448128267;3766.5856755756845;3778.5843557208686;4346.695731298779;4358.084802191575;4359.847405340861;4368.388425620416;4376.474823021258;5154.252633368141;5219.347581552306;5369.463053694677;5422.48486393792;5432.619716619878;1316.789313709802;1350.1831392007891;1351.425644101253;1360.653033476477;1366.0778974192579;851.948883067018;858.3176374782063;868.7828042989253;874.8775171475999;876.0626130040922;5121.564667003347;5137.897242055213;5152.330197074356;5173.793048278027;5209.426963034063;5481.725913704299;5535.640183388067;5543.113101903676;5667.518260947865;5696.974544582015;5220.112580861262;5229.058769421541;5230.555402790729;5232.843014709565;5233.188855727369;3064.4637188491924;3076.984615076955;3127.56214130022;3151.732102771244;3155.637101733284;5766.394528574523;5791.391903850119;5818.709064546841;5842.912356314659;5848.912266316009;5759.424057594207;5766.711664416763;5796.739146738322;5814.970925145347;5825.766969321265;5746.425357464387;5783.19035335045;5783.2192653992015;5821.068629019422;5905.291365036137;5548.0845660465575;5668.0364338063455;5676.120201368794;5684.232628595252;5686.09022556389;5509.586780991362;5537.390887002507;5541.722913854372;5542.168674698827;5543.695096769717;5777.306723193244;5792.333881603501;5801.709914504342;5815.2149459822385;5875.764969401176;3594.4428613564937;3629.1108678373967;3684.2631473704832;3695.870644527536;3718.1448266898224;5513.393526711979;5529.4470552945995;5548.9722551386985;5565.638233514808;5576.553875690016;5357.705326207096;5406.594505412031;5463.9180412294645;5465.562754979672;5473.67157970523;5400.459954004568;5432.565394768488;5450.809221677222;5465.863353416196;5486.670799752028;5308.840734777963;5318.920216196838;5326.748214169745;5345;5366.838994830161;5367.865803354791;5453.127499600045;5467.343918729778;5476.342838859362;5558.555315574825;5344;5357.089294819812;5372.838814835562;5415.675059496442;5432.103702889137 09:52:36 INFO - 2015-11-11 09:52:36,278 DEBUG : BROWSER_OUTPUT: |5;yui.html;617.4874853871287;618.4125081172884;631.6241836107517;647.6599785112816;649.1852724830337;10723.571057157715;11007;11885.168038237327;11929.10531710123;11996.220245684024;10979.066779323766;10983.890161098387;11027.779444411108;11037.889621103786;11053.336799792018;582.2750675409121;596.8179705189915;728.5810658871144;735.7351353512745;754.2570567990525;742.6361083069285;745.5116898431536;746.5446077892482;748.6705849426262;749.2619769527012;760.4524742185645;763.2482005224849;768.0131031624364;777.5878784244331;780.6292011294646;766.4366690482491;766.5975362934448;767.2021098058041;773.0800347586382;777.1529033353644;563.9210510528488;567.1719289836843;568.7867049856304;573.3206150711378;579.122629216737;10011.49942502872;10105.595776168944;10107.64623238183;10168.034036766496;10183.745406364826;9520.428774273565;9577;9981.500924953723;9994.100530952177;10283.177345812392;7701.807454813618;7908.841823163562;7915.248051435105;7982.281594656509;8025.117237103914;2716.3480764616547;2757.5725762506645;2803.1030070377487;2840.261532001674;2884.4663737208684;41065.79467102645;41154.58845411537;41841;41873.1625367494;41945;7359.852802943911;7467.514611550232;7600.50596711212;7641.541507509567;7891.526508409514;16009.839901601068;16071.35714571404;16102.838971610368;16188.595285117966;16249.918750406172;5507.449255074541;5719.7140142992685;5736.856578585485;5774.971125144348;5926.496247818897;2948.7346138847606;2967.7329040386467;2979.2254013956526;2982.5824384586176;2991.3269514359095;2214.977850221477;2269.1490690990877;2278.6012447821563;2290.6449500327476;2296.5636529059425;327.9032685357825;334.69041136948226;335.4113530753561;336.48181800027686;336.9208236064523;375.7839242435556;387.8390467955767;441.20582950688635;453.505678810092;471.1542780708636;5845.503132233723;6191.329557244502;6195.783147589813;6247.187865577446;6332.366763323631;376.7795839433907;478.9544993225638;486.0788805214099;492.7683988525387;501.393314089948;2962.7333539981505;3056.770742194344;3070.570120183176;3097.3340731742783;3127.56214130022;47474.050518989425;47745.28382074272;48379.75810120927;48541;48682;42466.15067698629;44775.77612111918;44889.551104488535;45050.09899802051;45363.773181134544;39835.60164398377;40742.79628601838;41092.178156436705;41151;41380.586194138275;6380.106785050004;6495.707693153725;6660.866782664417;6768.323167683192;6923.273056329214;29779.553306699985;30111;30439.695603043685;30587.08238752841;30984;37091.814540927124;38211.80894095512;39775;40104;40350.1929961405;8551.657933682583;8598.742037738877;8666.566671666518;8678.175573320525;8994.685186018458;8696.695615653422;8832.968417263937;8891.244244239311;9105.089491050841;9241.907580924104;8362.749117526484;8415;8644.740657780276;8751.824963500821;8923.553822308728;8366.581670916552;8509.489430634181;8611.095834937492;8623.65505379803;9135.086491351078;8221.876671850046;8362.66549338044;8389.328853691568;8405.915940840514;9105.908940910505;7105.729591938482;7559.584222867795;7559.659815308434;7831.295183433518;7831.921680783119;6796.524243302922;7081.46888983318;7262.237465066092;7455.4035677146785;7804.609769511389 09:52:36 INFO - 2015-11-11 09:52:36,278 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:52:36 INFO - 2015-11-11 09:52:36,278 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:52:36 INFO - 2015-11-11 09:52:36,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 09:52:36 INFO - 2015-11-11 09:52:36,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:52:36 INFO - 2015-11-11 09:52:36,279 DEBUG : BROWSER_OUTPUT: __startTimestamp1447264356262__endTimestamp 09:52:36 INFO - 2015-11-11 09:52:36,279 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,279 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:52:36 INFO - 2015-11-11 09:52:36,279 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:52:36 INFO - 2015-11-11 09:52:36,279 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,280 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4558.12 Median:4732.95 stddev:588.39 (12.4%) stddev-sans-first:570.19 09:52:36 INFO - 2015-11-11 09:52:36,280 DEBUG : BROWSER_OUTPUT: Values: 2618.6 2648.9 2666.2 2710.4 2721.7 4576.8 4621.5 4639.9 4649.3 4674.0 4441.6 4472.7 4524.4 4563.5 4641.3 4212.8 4226.6 4289.6 4311.9 4373.0 549.3 4144.9 4276.7 4289.3 4361.4 4113.9 4176.6 4188.2 4195.8 4246.6 4237.1 4257.9 4268.2 4269.1 4317.3 4029.0 4172.9 4219.0 4243.7 4279.1 4368.6 4456.7 4563.6 4619.0 4637.2 4772.6 4876.2 4907.0 4929.0 4957.1 4739.0 4814.0 4898.0 4908.0 4947.9 4336.5 4507.9 4583.8 4622.1 4715.3 5062.9 5064.4 5068.5 5078.2 5151.2 4647.4 4760.2 4774.0 4801.2 4822.1 4869.2 4882.5 4913.1 4928.8 4965.3 4845.1 4853.0 4869.0 4903.4 4922.5 4818.0 4825.0 4846.0 4861.2 4922.0 3878.3 3887.0 3898.9 3923.9 3944.4 3349.7 3516.5 3540.8 3546.3 3622.5 4567.0 4569.7 4588.7 4607.2 4660.4 4975.9 4980.7 5027.5 5053.7 5078.9 4542.4 4680.1 4724.5 4732.6 4733.0 4231.7 4295.9 4301.9 4330.2 4354.1 5084.6 5128.4 5143.1 5165.3 5198.2 4803.7 4915.9 4969.2 5008.9 5094.3 5103.7 5108.7 5128.4 5156.4 5182.8 4842.5 4905.1 4917.9 4961.4 4980.9 4721.9 4765.7 4856.9 4893.3 5029.1 4761.1 4807.8 4818.1 4819.7 4852.5 4733.4 4808.4 4832.9 4852.2 4898.7 4445.6 4565.7 4582.5 4602.7 4784.5 4801.0 4809.2 4823.5 4823.8 4891.7 4501.0 4719.6 4732.8 4757.3 4819.4 09:52:36 INFO - 2015-11-11 09:52:36,280 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,280 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36048.56 Median:32908.25 stddev:54680.05 (166.2%) stddev-sans-first:54768.08 09:52:36 INFO - 2015-11-11 09:52:36,281 DEBUG : BROWSER_OUTPUT: Values: 442.8 467.3 476.8 477.6 499.3 32910.5 33329.7 33454.3 33571.8 33772.5 34805.7 35492.6 35532.6 35609.8 35646.8 7741.6 7798.8 7837.7 7838.0 7848.5 7363.4 7703.9 7740.7 7751.6 7779.6 7593.2 7613.6 7687.5 7718.3 7752.5 7626.9 7715.1 7761.5 7780.8 8000.4 7506.6 7629.9 7645.5 7655.0 7657.9 32243.7 32422.8 32675.2 32906.0 33418.3 2153.1 2327.3 2338.7 2601.6 3206.2 22290.7 22649.4 23066.9 23437.9 23564.6 1843.7 1856.5 1894.1 1905.8 1933.0 199466.0 200359.0 201678.0 202412.0 205127.0 44614.8 46480.3 47716.5 52556.2 55214.0 50912.5 51984.7 51990.7 52513.7 52822.5 12829.2 13018.0 13046.6 13099.6 13166.1 9837.3 9922.4 9955.0 9955.8 9990.8 16400.8 16570.8 16599.9 16607.8 16617.3 6535.9 6818.2 6820.7 6876.4 6888.1 785.7 818.1 829.5 833.0 916.4 23678.3 23955.4 24070.2 24071.5 24278.3 880.8 923.8 984.6 986.0 1032.3 12396.6 12437.6 12510.4 12565.6 12624.4 251729.0 254394.0 259968.0 260815.0 261799.0 44317.0 44350.9 44386.8 44822.1 44919.0 1146.4 1149.5 1160.3 1171.6 1172.9 23290.4 23649.5 23680.0 23732.4 23834.3 41333.2 42511.6 42526.0 42920.1 43247.1 154907.0 156689.0 158240.0 158318.2 158549.0 24122.0 34860.8 35183.1 35781.0 36311.1 36973.0 37122.0 38032.4 38155.0 38340.8 29791.9 31351.4 31355.0 31637.2 31699.0 30955.5 31224.0 31311.7 31381.1 31554.8 31183.7 32259.8 32371.5 32586.3 32604.8 25154.5 27313.9 28077.3 28132.6 28286.6 20725.5 22100.3 22191.7 22239.1 22682.8 09:52:36 INFO - 2015-11-11 09:52:36,282 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,282 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21101.97 Median:230641.11 stddev:68463.00 (29.7%) stddev-sans-first:68637.19 09:52:36 INFO - 2015-11-11 09:52:36,283 DEBUG : BROWSER_OUTPUT: Values: 274.1 277.4 279.1 282.3 284.8 11216.0 14164.6 14271.9 14339.4 14871.7 9654.6 9782.7 9790.7 9791.1 14814.9 3595.2 3644.1 3758.2 3768.5 3795.7 3737.8 3738.3 3752.8 3757.4 3767.3 3704.1 3712.8 3717.3 3718.3 3741.3 3692.7 3695.8 3722.6 3732.2 3846.8 3356.2 3376.8 3381.1 3401.0 3416.8 10787.7 11101.3 11182.6 11187.4 11217.0 1495.6 1512.6 1559.3 1601.7 1651.2 7952.4 8050.5 8165.3 8172.3 8176.0 1236.5 1280.3 1305.9 1330.0 1390.5 47824.5 48702.3 48803.5 50032.7 50077.0 5330.5 5392.9 5418.5 5439.0 5459.3 6134.0 6194.2 6199.7 6232.8 6268.2 4490.2 4493.4 4512.0 4548.3 4556.2 4515.8 4659.8 4721.0 4724.6 4794.7 2439.6 2482.4 2482.7 2506.6 2506.8 883.2 888.2 892.2 898.7 938.9 323.4 327.2 338.8 341.7 347.5 8337.2 8675.0 8685.3 8820.3 8850.2 346.3 353.3 353.4 356.6 380.5 4587.3 4865.9 5209.2 5322.6 5542.5 399758.0 406974.0 409629.0 411680.0 456726.0 58802.0 59178.7 59485.8 60265.0 61467.7 412.8 432.1 435.4 435.5 437.9 8993.1 9065.9 9073.0 9189.2 9222.6 27950.6 28286.6 28297.7 29175.0 29180.1 30891.8 38826.8 39418.6 40100.6 40539.8 5060.4 5071.0 5202.0 5207.4 5224.7 9571.5 9753.6 9834.1 9855.9 9882.3 7813.0 8288.3 8316.7 8425.9 8505.7 8120.2 8188.0 8217.1 8360.8 8469.4 8124.0 8483.4 8653.3 8676.1 8801.1 5127.3 5149.5 5198.7 5201.9 5218.5 8419.5 8574.6 8711.3 8728.8 8795.4 09:52:36 INFO - 2015-11-11 09:52:36,284 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,284 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4615.27 Median:5911.59 stddev:2410.47 (40.8%) stddev-sans-first:2405.14 09:52:36 INFO - 2015-11-11 09:52:36,284 DEBUG : BROWSER_OUTPUT: Values: 1402.2 1474.5 1481.2 1482.7 1489.8 5954.9 5985.9 6612.9 6952.8 6989.8 6540.2 6570.5 6704.0 6729.3 6772.6 1798.2 1869.9 1875.2 1879.2 1882.4 1850.7 1866.3 1871.1 1893.3 1894.1 1865.7 1889.9 1891.9 1909.5 1915.3 1826.8 1862.6 1867.8 1889.8 1897.9 1843.7 1845.1 1862.9 1882.8 1887.5 6573.2 6756.2 6757.9 6783.2 6786.7 3857.5 4081.5 4091.7 4119.5 4127.7 2106.3 2173.0 2389.0 2426.1 2479.1 696.8 698.7 702.8 706.5 716.7 8144.7 8149.6 8171.9 8216.8 8251.6 3594.9 3622.6 3661.5 3686.5 3750.2 7820.8 7874.6 7880.9 7893.4 7960.4 4147.1 4150.5 4157.0 4163.8 4175.1 3743.4 3763.7 3777.7 3787.0 3791.7 3026.3 3033.8 3055.5 3077.2 3093.5 937.7 938.0 973.5 1004.2 1004.9 1001.7 1007.2 1057.0 1105.0 1105.1 6291.0 6292.0 6342.7 6356.1 6402.8 374.3 378.6 379.0 379.6 383.6 4866.3 4952.3 5001.5 5013.1 5016.8 7090.6 7892.3 7995.4 8024.4 8077.9 7858.4 7859.3 7960.2 7961.0 8012.9 6041.6 6229.0 6274.4 6326.4 6413.0 6323.7 6355.3 6383.7 6391.0 6419.0 6608.3 6951.8 6973.9 7114.6 7128.6 7098.4 7264.9 7283.9 7312.0 7359.7 5886.0 6015.5 6026.7 6028.2 6053.7 6445.3 6492.6 6493.9 6498.0 6521.4 5918.4 6110.6 6113.3 6137.9 6236.1 5754.1 5841.8 5904.8 5974.2 6002.0 6049.7 6059.0 6113.5 6139.8 6163.4 5158.6 5207.1 5207.8 5253.3 5308.9 5420.7 5489.3 5493.6 5507.4 5556.1 09:52:36 INFO - 2015-11-11 09:52:36,286 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,286 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4521.96 Median:5219.73 stddev:1387.43 (26.6%) stddev-sans-first:1353.98 09:52:36 INFO - 2015-11-11 09:52:36,286 DEBUG : BROWSER_OUTPUT: Values: 262.1 262.8 266.8 270.1 272.7 5151.4 5179.4 5193.7 5211.7 5222.7 4989.9 5124.7 5144.2 5165.8 5172.1 3942.5 3957.3 3966.2 3983.3 3993.4 3951.3 3961.0 3962.6 3971.9 3977.3 3928.4 3929.4 3930.7 3931.7 3958.0 3775.4 3830.8 3858.5 3884.0 3899.5 3299.1 3302.3 3315.5 3343.5 3355.4 4868.2 4943.5 4972.3 4976.8 5019.8 4373.8 4383.9 4416.2 4423.1 4451.5 5380.5 5380.9 5409.8 5432.3 5457.6 3596.1 3617.1 3619.5 3643.6 3649.4 5544.9 5629.3 5649.3 5672.4 5705.2 3674.3 3676.2 3689.8 3689.9 3726.8 3743.1 3758.6 3766.6 3766.6 3778.6 4346.7 4358.1 4359.8 4368.4 4376.5 5154.3 5219.3 5369.5 5422.5 5432.6 1316.8 1350.2 1351.4 1360.7 1366.1 851.9 858.3 868.8 874.9 876.1 5121.6 5137.9 5152.3 5173.8 5209.4 5481.7 5535.6 5543.1 5667.5 5697.0 5220.1 5229.1 5230.6 5232.8 5233.2 3064.5 3077.0 3127.6 3151.7 3155.6 5766.4 5791.4 5818.7 5842.9 5848.9 5759.4 5766.7 5796.7 5815.0 5825.8 5746.4 5783.2 5783.2 5821.1 5905.3 5548.1 5668.0 5676.1 5684.2 5686.1 5509.6 5537.4 5541.7 5542.2 5543.7 5777.3 5792.3 5801.7 5815.2 5875.8 3594.4 3629.1 3684.3 3695.9 3718.1 5513.4 5529.4 5549.0 5565.6 5576.6 5357.7 5406.6 5463.9 5465.6 5473.7 5400.5 5432.6 5450.8 5465.9 5486.7 5308.8 5318.9 5326.7 5345.0 5366.8 5367.9 5453.1 5467.3 5476.3 5558.6 5344.0 5357.1 5372.8 5415.7 5432.1 09:52:36 INFO - 2015-11-11 09:52:36,286 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,286 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11445.32 Median:3146.52 stddev:13892.26 (441.5%) stddev-sans-first:13907.43 09:52:36 INFO - 2015-11-11 09:52:36,288 DEBUG : BROWSER_OUTPUT: Values: 617.5 618.4 631.6 647.7 649.2 10723.6 11007.0 11885.2 11929.1 11996.2 10979.1 10983.9 11027.8 11037.9 11053.3 582.3 596.8 728.6 735.7 754.3 742.6 745.5 746.5 748.7 749.3 760.5 763.2 768.0 777.6 780.6 766.4 766.6 767.2 773.1 777.2 563.9 567.2 568.8 573.3 579.1 10011.5 10105.6 10107.6 10168.0 10183.7 9520.4 9577.0 9981.5 9994.1 10283.2 7701.8 7908.8 7915.2 7982.3 8025.1 2716.3 2757.6 2803.1 2840.3 2884.5 41065.8 41154.6 41841.0 41873.2 41945.0 7359.9 7467.5 7600.5 7641.5 7891.5 16009.8 16071.4 16102.8 16188.6 16249.9 5507.4 5719.7 5736.9 5775.0 5926.5 2948.7 2967.7 2979.2 2982.6 2991.3 2215.0 2269.1 2278.6 2290.6 2296.6 327.9 334.7 335.4 336.5 336.9 375.8 387.8 441.2 453.5 471.2 5845.5 6191.3 6195.8 6247.2 6332.4 376.8 479.0 486.1 492.8 501.4 2962.7 3056.8 3070.6 3097.3 3127.6 47474.1 47745.3 48379.8 48541.0 48682.0 42466.2 44775.8 44889.6 45050.1 45363.8 39835.6 40742.8 41092.2 41151.0 41380.6 6380.1 6495.7 6660.9 6768.3 6923.3 29779.6 30111.0 30439.7 30587.1 30984.0 37091.8 38211.8 39775.0 40104.0 40350.2 8551.7 8598.7 8666.6 8678.2 8994.7 8696.7 8833.0 8891.2 9105.1 9241.9 8362.7 8415.0 8644.7 8751.8 8923.6 8366.6 8509.5 8611.1 8623.7 9135.1 8221.9 8362.7 8389.3 8405.9 9105.9 7105.7 7559.6 7559.7 7831.3 7831.9 6796.5 7081.5 7262.2 7455.4 7804.6 09:52:36 INFO - 2015-11-11 09:52:36,288 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:52:36 INFO - 2015-11-11 09:52:36,288 DEBUG : BROWSER_OUTPUT: 09:52:36 INFO - 2015-11-11 09:52:36,961 INFO : Browser exited with error code: 0 09:52:36 INFO - 2015-11-11 09:52:36,996 INFO : Completed test dromaeo_css (00:18:34) 09:52:36 INFO - 2015-11-11 09:52:36,996 INFO : Starting test kraken 09:52:36 INFO - 2015-11-11 09:52:36,996 DEBUG : operating with platform_type : mac_ 09:52:36 INFO - 2015-11-11 09:52:36,996 INFO : Initialising browser for kraken test... 09:52:37 INFO - 2015-11-11 09:52:37,013 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpTvn3MM/profile http://localhost:49266/getInfo.html 09:52:40 INFO - 2015-11-11 09:52:40,502 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:52:40 INFO - 2015-11-11 09:52:40,502 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:52:40 INFO - 2015-11-11 09:52:40,502 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:52:40 INFO - 2015-11-11 09:52:40,502 DEBUG : BROWSER_OUTPUT: __metrics 09:52:41 INFO - 2015-11-11 09:52:41,226 INFO : Browser initialized. 09:52:41 INFO - 2015-11-11 09:52:41,227 INFO : Running cycle 1/1 for kraken test... 09:52:41 INFO - 2015-11-11 09:52:41,227 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpTvn3MM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:52:53 INFO - 2015-11-11 09:52:53,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 240779264 09:52:53 INFO - 2015-11-11 09:52:53,642 DEBUG : BROWSER_OUTPUT: 09:52:56 INFO - 2015-11-11 09:52:56,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:57 INFO - 2015-11-11 09:52:57,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 259272704 09:52:57 INFO - 2015-11-11 09:52:57,149 DEBUG : BROWSER_OUTPUT: 09:53:00 INFO - 2015-11-11 09:53:00,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 09:53:00 INFO - 2015-11-11 09:53:00,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 267190272 09:53:00 INFO - 2015-11-11 09:53:00,847 DEBUG : BROWSER_OUTPUT: 09:53:04 INFO - 2015-11-11 09:53:04,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 09:53:04 INFO - 2015-11-11 09:53:04,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 266522624 09:53:04 INFO - 2015-11-11 09:53:04,822 DEBUG : BROWSER_OUTPUT: 09:53:07 INFO - 2015-11-11 09:53:07,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 09:53:07 INFO - 2015-11-11 09:53:07,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 267091968 09:53:07 INFO - 2015-11-11 09:53:07,669 DEBUG : BROWSER_OUTPUT: 09:53:10 INFO - 2015-11-11 09:53:10,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:10 INFO - 2015-11-11 09:53:10,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 267714560 09:53:10 INFO - 2015-11-11 09:53:10,667 DEBUG : BROWSER_OUTPUT: 09:53:14 INFO - 2015-11-11 09:53:14,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:14 INFO - 2015-11-11 09:53:14,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 267665408 09:53:14 INFO - 2015-11-11 09:53:14,784 DEBUG : BROWSER_OUTPUT: 09:53:18 INFO - 2015-11-11 09:53:18,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:19 INFO - 2015-11-11 09:53:19,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 266276864 09:53:19 INFO - 2015-11-11 09:53:19,019 DEBUG : BROWSER_OUTPUT: 09:53:22 INFO - 2015-11-11 09:53:22,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 09:53:22 INFO - 2015-11-11 09:53:22,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 268029952 09:53:22 INFO - 2015-11-11 09:53:22,986 DEBUG : BROWSER_OUTPUT: 09:53:24 INFO - 2015-11-11 09:53:24,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:25 INFO - 2015-11-11 09:53:25,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 268275712 09:53:25 INFO - 2015-11-11 09:53:25,340 DEBUG : BROWSER_OUTPUT: 09:53:27 INFO - 2015-11-11 09:53:27,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:27 INFO - 2015-11-11 09:53:27,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 267948032 09:53:27 INFO - 2015-11-11 09:53:27,988 DEBUG : BROWSER_OUTPUT: 09:53:30 INFO - 2015-11-11 09:53:30,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:30 INFO - 2015-11-11 09:53:30,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 267849728 09:53:30 INFO - 2015-11-11 09:53:30,952 DEBUG : BROWSER_OUTPUT: 09:53:33 INFO - 2015-11-11 09:53:33,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:34 INFO - 2015-11-11 09:53:34,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 267649024 09:53:34 INFO - 2015-11-11 09:53:34,598 DEBUG : BROWSER_OUTPUT: 09:53:37 INFO - 2015-11-11 09:53:37,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:38 INFO - 2015-11-11 09:53:38,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 267227136 09:53:38 INFO - 2015-11-11 09:53:38,218 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 09:53:40 INFO - 2015-11-11 09:53:40,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 268832768 09:53:40 INFO - 2015-11-11 09:53:40,405 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,405 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:53:40 INFO - 2015-11-11 09:53:40,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:53:40 INFO - 2015-11-11 09:53:40,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:53:40 INFO - 2015-11-11 09:53:40,406 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:53:40 INFO - 2015-11-11 09:53:40,406 DEBUG : BROWSER_OUTPUT: |0;ai-astar;126;124;140;139;141;144;132;135;134;135 09:53:40 INFO - 2015-11-11 09:53:40,406 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;167;194;205;167;188;180;163;204;165 09:53:40 INFO - 2015-11-11 09:53:40,406 DEBUG : BROWSER_OUTPUT: |2;audio-dft;207;210;209;210;201;203;202;204;216;209 09:53:40 INFO - 2015-11-11 09:53:40,406 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;93;98;147;83;88;90;91;125;83 09:53:40 INFO - 2015-11-11 09:53:40,407 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;103;107;154;110;114;115;149;108;110;154 09:53:40 INFO - 2015-11-11 09:53:40,407 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;143;156;155;149;150;142;150;154;143 09:53:40 INFO - 2015-11-11 09:53:40,407 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;156;164;162;156;157;156;164;163;156 09:53:40 INFO - 2015-11-11 09:53:40,407 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;128;138;133;133;133;133;136;134;133;128 09:53:40 INFO - 2015-11-11 09:53:40,407 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;72;76;79;79;79;78;87;81;82 09:53:40 INFO - 2015-11-11 09:53:40,408 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;82;79;82;84;86;84;86;84;85;87 09:53:40 INFO - 2015-11-11 09:53:40,408 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;107;113;111;114;110;108;107;112;109 09:53:40 INFO - 2015-11-11 09:53:40,408 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;159;168;163;175;163;176;163;166;164;163 09:53:40 INFO - 2015-11-11 09:53:40,408 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;185;190;191;191;194;193;191;191;197;197 09:53:40 INFO - 2015-11-11 09:53:40,408 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;84;87;89;93;92;93;91;92;89 09:53:40 INFO - 2015-11-11 09:53:40,409 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:53:40 INFO - 2015-11-11 09:53:40,410 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:53:40 INFO - 2015-11-11 09:53:40,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,746 09:53:40 INFO - 2015-11-11 09:53:40,410 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:53:40 INFO - 2015-11-11 09:53:40,410 DEBUG : BROWSER_OUTPUT: __startTimestamp1447264420404__endTimestamp 09:53:40 INFO - 2015-11-11 09:53:40,410 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:135.00 Median:137.00 stddev:6.41 (4.7%) stddev-sans-first:5.92 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: Values: 126.0 124.0 140.0 139.0 141.0 144.0 132.0 135.0 134.0 135.0 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,411 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.10 Median:184.00 stddev:16.00 (8.7%) stddev-sans-first:16.93 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: Values: 178.0 167.0 194.0 205.0 167.0 188.0 180.0 163.0 204.0 165.0 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:207.10 Median:209.00 stddev:4.63 (2.2%) stddev-sans-first:4.91 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: Values: 207.0 210.0 209.0 210.0 201.0 203.0 202.0 204.0 216.0 209.0 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,413 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.20 Median:89.00 stddev:21.12 (23.7%) stddev-sans-first:21.76 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: Values: 84.0 93.0 98.0 147.0 83.0 88.0 90.0 91.0 125.0 83.0 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:122.40 Median:114.50 stddev:20.97 (18.3%) stddev-sans-first:21.04 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: Values: 103.0 107.0 154.0 110.0 114.0 115.0 149.0 108.0 110.0 154.0 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,414 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:149.20 Median:150.00 stddev:5.09 (3.4%) stddev-sans-first:5.40 09:53:40 INFO - 2015-11-11 09:53:40,415 DEBUG : BROWSER_OUTPUT: Values: 150.0 143.0 156.0 155.0 149.0 150.0 142.0 150.0 154.0 143.0 09:53:40 INFO - 2015-11-11 09:53:40,415 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,415 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:159.00 Median:159.50 stddev:3.71 (2.3%) stddev-sans-first:3.77 09:53:40 INFO - 2015-11-11 09:53:40,415 DEBUG : BROWSER_OUTPUT: Values: 156.0 156.0 164.0 162.0 156.0 157.0 156.0 164.0 163.0 156.0 09:53:40 INFO - 2015-11-11 09:53:40,415 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:132.90 Median:133.00 stddev:3.07 (2.3%) stddev-sans-first:2.70 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: Values: 128.0 138.0 133.0 133.0 133.0 133.0 136.0 134.0 133.0 128.0 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:78.10 Median:79.00 stddev:5.26 (6.7%) stddev-sans-first:4.12 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 76.0 79.0 79.0 79.0 78.0 87.0 81.0 82.0 09:53:40 INFO - 2015-11-11 09:53:40,416 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,417 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.90 Median:84.50 stddev:2.38 (2.8%) stddev-sans-first:2.42 09:53:40 INFO - 2015-11-11 09:53:40,417 DEBUG : BROWSER_OUTPUT: Values: 82.0 79.0 82.0 84.0 86.0 84.0 86.0 84.0 85.0 87.0 09:53:40 INFO - 2015-11-11 09:53:40,417 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,417 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:109.40 Median:110.50 stddev:3.31 (3.0%) stddev-sans-first:2.57 09:53:40 INFO - 2015-11-11 09:53:40,418 DEBUG : BROWSER_OUTPUT: Values: 103.0 107.0 113.0 111.0 114.0 110.0 108.0 107.0 112.0 109.0 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:166.00 Median:165.00 stddev:5.52 (3.3%) stddev-sans-first:5.24 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: Values: 159.0 168.0 163.0 175.0 163.0 176.0 163.0 166.0 164.0 163.0 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.00 Median:192.00 stddev:3.53 (1.8%) stddev-sans-first:2.68 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: Values: 185.0 190.0 191.0 191.0 194.0 193.0 191.0 191.0 197.0 197.0 09:53:40 INFO - 2015-11-11 09:53:40,419 DEBUG : BROWSER_OUTPUT: 09:53:40 INFO - 2015-11-11 09:53:40,420 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.10 Median:91.50 stddev:4.04 (4.4%) stddev-sans-first:3.04 09:53:40 INFO - 2015-11-11 09:53:40,420 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 87.0 89.0 93.0 92.0 93.0 91.0 92.0 89.0 09:53:40 INFO - 2015-11-11 09:53:40,420 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:53:40 INFO - 2015-11-11 09:53:40,420 DEBUG : BROWSER_OUTPUT: 09:53:41 INFO - 2015-11-11 09:53:41,134 INFO : Browser exited with error code: 0 09:53:41 INFO - 2015-11-11 09:53:41,189 INFO : Completed test kraken (00:01:04) 09:53:41 INFO - 2015-11-11 09:53:41,190 INFO : Starting test v8_7 09:53:41 INFO - 2015-11-11 09:53:41,190 DEBUG : operating with platform_type : mac_ 09:53:41 INFO - 2015-11-11 09:53:41,190 INFO : Initialising browser for v8_7 test... 09:53:41 INFO - 2015-11-11 09:53:41,206 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpq7vT2e/profile http://localhost:49266/getInfo.html 09:53:44 INFO - 2015-11-11 09:53:44,606 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:53:44 INFO - 2015-11-11 09:53:44,606 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:53:44 INFO - 2015-11-11 09:53:44,606 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:53:44 INFO - 2015-11-11 09:53:44,606 DEBUG : BROWSER_OUTPUT: __metrics 09:53:45 INFO - 2015-11-11 09:53:45,340 INFO : Browser initialized. 09:53:45 INFO - 2015-11-11 09:53:45,340 INFO : Running cycle 1/1 for v8_7 test... 09:53:45 INFO - 2015-11-11 09:53:45,340 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/T/tmpq7vT2e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:53:57 INFO - 2015-11-11 09:53:57,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 241090560 09:53:57 INFO - 2015-11-11 09:53:57,665 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 09:54:20 INFO - 2015-11-11 09:54:20,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 260763648 09:54:20 INFO - 2015-11-11 09:54:20,536 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,537 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:54:20 INFO - 2015-11-11 09:54:20,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:54:20 INFO - 2015-11-11 09:54:20,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:54:20 INFO - 2015-11-11 09:54:20,537 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:54:20 INFO - 2015-11-11 09:54:20,537 DEBUG : BROWSER_OUTPUT: |0;Richards;203.5002035002035 09:54:20 INFO - 2015-11-11 09:54:20,538 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;237.36055067647757 09:54:20 INFO - 2015-11-11 09:54:20,538 DEBUG : BROWSER_OUTPUT: |2;Encrypt;386.24951718810354 09:54:20 INFO - 2015-11-11 09:54:20,538 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6836.734693877551 09:54:20 INFO - 2015-11-11 09:54:20,538 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1342.2818791946308 09:54:20 INFO - 2015-11-11 09:54:20,538 DEBUG : BROWSER_OUTPUT: |5;Earley;1096.4912280701753 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: |6;Boyer;15194.029850746268 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: |7;RegExp;34542.372881355936 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: |8;Splay;801.924619085806 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6823.1292517006805 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: __startTimestamp1447264460536__endTimestamp 09:54:20 INFO - 2015-11-11 09:54:20,539 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,540 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:54:20 INFO - 2015-11-11 09:54:20,541 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:54:20 INFO - 2015-11-11 09:54:20,541 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,541 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:203.50 Median:203.50 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,541 DEBUG : BROWSER_OUTPUT: Values: 203.5 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:237.36 Median:237.36 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: Values: 237.4 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:386.25 Median:386.25 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: Values: 386.2 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,542 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6836.73 Median:6836.73 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: Values: 6836.7 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1342.28 Median:1342.28 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: Values: 1342.3 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1096.49 Median:1096.49 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: Values: 1096.5 09:54:20 INFO - 2015-11-11 09:54:20,543 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15194.03 Median:15194.03 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: Values: 15194.0 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34542.37 Median:34542.37 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: Values: 34542.4 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,544 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: Values: 801.9 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6823.13 Median:6823.13 stddev:0.00 (0.0%) 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: Values: 6823.1 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:54:20 INFO - 2015-11-11 09:54:20,545 DEBUG : BROWSER_OUTPUT: 09:54:21 INFO - 2015-11-11 09:54:21,255 INFO : Browser exited with error code: 0 09:54:21 INFO - 2015-11-11 09:54:21,280 INFO : Completed test v8_7 (00:00:40) 09:54:21 INFO - 2015-11-11 09:54:21,497 INFO : Completed test suite (00:20:19) 09:54:21 INFO - 2015-11-11 09:54:21,497 DEBUG : Working with test: dromaeo_css 09:54:21 INFO - 2015-11-11 09:54:21,497 DEBUG : Generating results file: dromaeo_css 09:54:21 INFO - 2015-11-11 09:54:21,498 DEBUG : Working with test: kraken 09:54:21 INFO - 2015-11-11 09:54:21,498 DEBUG : Generating results file: kraken 09:54:21 INFO - 2015-11-11 09:54:21,498 INFO : javascript benchmark 09:54:21 INFO - 2015-11-11 09:54:21,499 DEBUG : Working with test: v8_7 09:54:21 INFO - 2015-11-11 09:54:21,499 DEBUG : Generating results file: v8_7 09:54:21 INFO - 2015-11-11 09:54:21,499 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:21 INFO - 2015-11-11 09:54:21,548 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 09:54:21 INFO - 2015-11-11 09:54:21,548 DEBUG : process_Request line: dromaeo_css 5520.80 graph.html#tests=[[72,64,57]] 09:54:21 INFO - 2015-11-11 09:54:21,548 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:21 INFO - 2015-11-11 09:54:21,575 DEBUG : process_Request line: kraken 1903.40 graph.html#tests=[[232,64,57]] 09:54:21 INFO - 2015-11-11 09:54:21,575 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:54:21 INFO - 2015-11-11 09:54:21,604 DEBUG : process_Request line: v8_7 16099.51 graph.html#tests=[[230,64,57]] 09:54:21 INFO - 2015-11-11 09:54:21,605 INFO : javascript benchmark 09:54:21 INFO - 2015-11-11 09:54:21,607 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [274.07363112679144, 277.4326502302791, 279.1096402476101, 282.3196097405253, 284.81771666133676, 11216.0, 14164.575062748121, 14271.857281427196, 14339.426422943083, 14871.702565948675, 9654.613815447374, 9782.706518804447, 9790.706278811629, 9791.069848364394, 14814.851851481482, 3595.1731101846462, 3644.1071937375314, 3758.2483503299313, 3768.5100936878166, 3795.6773674237725, 3737.794421306827, 3738.3457894868425, 3752.8311225994757, 3757.3988161894104, 3767.284215998965, 3704.1480459494333, 3712.777233365993, 3717.3494638438165, 3718.3492888744495, 3741.3452645787015, 3692.6861216796606, 3695.815209239527, 3722.553293604771, 3732.1789206374556, 3846.788426636534, 3356.2448449099, 3376.7805092668896, 3381.1040074380307, 3400.996705971744, 3416.8120753358558, 10787.67636970892, 11101.333919964827, 11182.552697892075, 11187.384693841836, 11217.0, 1495.5588101509973, 1512.629405795576, 1559.2593518078936, 1601.7116918954584, 1651.2156725555385, 7952.3638108951145, 8050.476719013245, 8165.265126138676, 8172.305354044914, 8176.01887773471, 1236.4806781151938, 1280.2510531339178, 1305.9151155174884, 1329.9800502992464, 1390.4994202087241, 47824.521754782356, 48702.26946595804, 48803.51196488025, 50032.74983625095, 50077.0, 5330.520253177233, 5392.946070539245, 5418.485243901823, 5438.972805135949, 5459.317585301837, 6134.018557030854, 6194.163787888668, 6199.659018753921, 6232.844178895473, 6268.216472940882, 4490.2142125127975, 4493.393391892118, 4512.0, 4548.340490628841, 4556.225441674923, 4515.841945531891, 4659.813607455664, 4720.976395118002, 4724.622030237572, 4794.664373493892, 2439.646251293588, 2482.4042229865063, 2482.689663792026, 2506.5738824399896, 2506.7994560435486, 883.1565854608833, 888.1873086126122, 892.1836519584638, 898.7034278688018, 938.9201917836924, 323.369429612257, 327.2293748222948, 338.78656446438583, 341.6862164975665, 347.45623099848655, 8337.249647531751, 8675.045744968049, 8685.305175585938, 8820.25027872638, 8850.20348168668, 346.28492163681915, 353.2528701795735, 353.35865404291644, 356.61485595556735, 380.4616467698231, 4587.266037433995, 4865.9026819463415, 5209.166533354645, 5322.561364360796, 5542.501174894279, 399758.0, 406974.0, 409629.0, 411680.0, 456726.0, 58802.0, 59178.70410648005, 59485.75399583068, 60265.0, 61467.69266153641, 412.77916314771454, 432.0796703022542, 435.4382846128522, 435.47742708749627, 437.9189849877783, 8993.111446596287, 9065.90934090677, 9072.95463522678, 9189.218916392181, 9222.584983675884, 27950.58074128849, 28286.575701364083, 28297.717022830333, 29175.0, 29180.10329328587, 30891.845540772152, 38826.80586597162, 39418.605813941496, 40100.598994009684, 40539.797301014485, 5060.443351231435, 5071.0, 5201.973990130176, 5207.401148867777, 5224.712640804641, 9571.521423928636, 9753.60985560598, 9834.114929656365, 9855.852162217716, 9882.308238423242, 7812.960935195288, 8288.336933045463, 8316.6673333066, 8425.915740842513, 8505.74482765518, 8120.22857828529, 8187.959060204661, 8217.096119426978, 8360.790980225544, 8469.449485783405, 8123.959380203298, 8483.406161568631, 8653.307735381028, 8676.132386761527, 8801.075887032026, 5127.307813445286, 5149.510796474329, 5198.714070726146, 5201.895962080813, 5218.530332269962, 8419.452735572168, 8574.571271436278, 8711.346649001223, 8728.825423491622, 8795.384323097322], "dojo.html": [2618.5941179117235, 2648.854313012784, 2666.2401215653545, 2710.390162213502, 2721.687005994311, 4576.794044268012, 4621.514740952198, 4639.884002899929, 4649.325847752074, 4673.953260467394, 4441.600255976961, 4472.731636101837, 4524.411826462555, 4563.543645635435, 4641.25739881619, 4212.810423530948, 4226.577342265764, 4289.571042895701, 4311.892202694927, 4372.956270437303, 549.287320920814, 4144.917101657965, 4276.679249056333, 4289.335153051282, 4361.411209486726, 4113.8971525711795, 4176.644985176264, 4188.162367526476, 4195.832166713328, 4246.639035681956, 4237.110206856533, 4257.87226383209, 4268.210381079479, 4269.082147338306, 4317.309230523101, 4028.9798551007057, 4172.91654166918, 4218.978905105455, 4243.702940794145, 4279.079997800488, 4368.628666563346, 4456.6880318377725, 4563.589276965055, 4619.030003699228, 4637.234856248749, 4772.594329481998, 4876.195427754416, 4906.975465122688, 4928.964917367357, 4957.132501812169, 4739.028499157665, 4813.951860481386, 4898.044881248158, 4907.969326441452, 4947.90104197914, 4336.544662810359, 4507.909841803178, 4583.770811459447, 4622.14490319292, 4715.292706094045, 5062.949370506321, 5064.41759197697, 5068.467810879878, 5078.187490001582, 5151.201563757623, 4647.442306923191, 4760.166970780099, 4774.0, 4801.18379875422, 4822.083804077214, 4869.220924652039, 4882.462929077798, 4913.140200464904, 4928.827491037797, 4965.32968049316, 4845.127876982177, 4853.0, 4868.9756551217015, 4903.411590609078, 4922.507749225048, 4818.036392721399, 4825.0, 4845.951540484621, 4861.173600487855, 4921.975390123098, 3878.3212937735784, 3886.9611303887164, 3898.8830335089992, 3923.862664806718, 3944.4280579315837, 3349.6650334966794, 3516.507688923553, 3540.7698499597445, 3546.3261980223674, 3622.5290712207243, 4566.97716511422, 4569.725816450957, 4588.655850811136, 4607.216773148572, 4660.39414876064, 4975.90048199034, 4980.701157930535, 5027.4721154279005, 5053.67151135175, 5078.898422031612, 4542.432195975503, 4680.063987202505, 4724.480307166209, 4732.5977291929885, 4732.95267047332, 4231.724937879089, 4295.935560966588, 4301.913961720748, 4330.198913201005, 4354.129174165179, 5084.56781173597, 5128.358955130609, 5143.1334333579825, 5165.302684137593, 5198.194279886624, 4803.735794531334, 4915.926261106015, 4969.229769385751, 5008.874778130576, 5094.312267843942, 5103.693778373309, 5108.744562771921, 5128.410232823124, 5156.381234251914, 5182.818601348935, 4842.4673285939225, 4905.1416002200185, 4917.877053073702, 4961.355023846877, 4980.925286120639, 4721.881952951204, 4765.7140571565815, 4856.854294371175, 4893.339399181207, 5029.145045342374, 4761.095391875532, 4807.7836497357, 4818.10864989978, 4819.6867203631655, 4852.539008794159, 4733.408323959505, 4808.3989501312335, 4832.8791780205775, 4852.17513022794, 4898.706077635354, 4445.644348452181, 4565.680402371802, 4582.473015603248, 4602.746848923208, 4784.47370789206, 4800.951990480051, 4809.182438985311, 4823.469418364048, 4823.758812059453, 4891.73095479752, 4500.954990450054, 4719.622430205507, 4732.787024583971, 4757.334182087687, 4819.421669399694], "mootools.html": [1402.249796358948, 1474.5281509916824, 1481.207553958632, 1482.6664000599867, 1489.8063251777266, 5954.940450595493, 5985.850353741148, 6612.86774264515, 6952.756653517122, 6989.755358562451, 6540.215174179093, 6570.540062195648, 6703.966480167593, 6729.25978142404, 6772.593644381341, 1798.1548672124113, 1869.8597605179598, 1875.1561797191318, 1879.2483006797322, 1882.3599976008154, 1850.704506845207, 1866.272153859989, 1871.0644677661169, 1893.3278686066456, 1894.0529735132434, 1865.7387965684816, 1889.8771579847335, 1891.8675692701515, 1909.5035290824346, 1915.2626238898056, 1826.835584797368, 1862.5622978600086, 1867.794542600313, 1889.8488120950292, 1897.8576606754411, 1843.6681397348473, 1845.0866820923595, 1862.9161687724086, 1882.8305452509203, 1887.4620733091003, 6573.1783527059115, 6756.155480564929, 6757.898631520531, 6783.186017677861, 6786.660666966632, 3857.4792403025795, 4081.4898137732785, 4091.693123015756, 4119.526254480743, 4127.731697439657, 2106.3470324199548, 2172.989559854675, 2389.0, 2426.065964603623, 2479.1323036937106, 696.8257935516122, 698.671624336561, 702.80523110712, 706.4948561778302, 716.6739133694157, 8144.714934977247, 8149.633266503021, 8171.877421838677, 8216.83566328676, 8251.587420628945, 3594.946075808865, 3622.601513833476, 3661.5240018797917, 3686.5207523021836, 3750.1937083527173, 7820.765377038698, 7874.645640946172, 7880.881786773203, 7893.368530517545, 7960.40296977729, 4147.149834284025, 4150.481189851269, 4157.023099571598, 4163.791810409528, 4175.123224122968, 3743.3636281832155, 3763.6800871925643, 3777.7355585109326, 3786.962130378716, 3791.658750712449, 3026.3493348930087, 3033.772467064935, 3055.4958431858495, 3077.2460747117098, 3093.474109401407, 937.681188395935, 938.0385105267155, 973.4500007495742, 1004.1916257412706, 1004.8794144702537, 1001.67946257197, 1007.189212683782, 1056.9524371403306, 1104.9834252486219, 1105.1159072741775, 6290.968545157245, 6292.0, 6342.746290148342, 6356.14192084072, 6402.775902843471, 374.32994939059324, 378.56843198753444, 378.9905252368713, 379.63554987212035, 383.5646541175786, 4866.31871537985, 4952.331435256195, 5001.474845141281, 5013.147764879979, 5016.799328026838, 7090.645467726593, 7892.289693927574, 7995.360371170293, 8024.438289319808, 8077.919220807834, 7858.371330293563, 7859.331956783623, 7960.243776841191, 7961.044674638964, 8012.879806802903, 6041.607295525777, 6228.968855155696, 6274.435300822856, 6326.398992095744, 6413.005984072476, 6323.683815809283, 6355.269144048493, 6383.7127329271225, 6391.041343798467, 6419.0, 6608.339166083353, 6951.826204344932, 6973.860522789617, 7114.608696521741, 7128.607926564089, 7098.396636285767, 7264.927350726425, 7283.927160728324, 7311.963440182765, 7359.668814903235, 5886.028805247086, 6015.548833837567, 6026.728797204224, 6028.216331876828, 6053.697315134314, 6445.323241059621, 6492.577982431127, 6493.935060649333, 6498.0, 6521.445677117308, 5918.408159184047, 6110.633361998294, 6113.327533971348, 6137.938620613737, 6236.064590311308, 5754.108113242454, 5841.795537156179, 5904.763809447746, 5974.2233509643465, 6002.0, 6049.727762250621, 6058.969705151446, 6113.5414843886, 6139.84650383744, 6163.38366163398, 5158.587313015025, 5207.140821764367, 5207.765650545659, 5253.343332083489, 5308.946910530845, 5420.7289635518855, 5489.34127904654, 5493.615446918678, 5507.449255074461, 5556.111022236423], "ext.html": [442.7808234923711, 467.3433825475207, 476.81165939453916, 477.5749582871244, 499.32591002147126, 32910.50634240486, 33329.66670333296, 33454.33091338178, 33571.832140839295, 33772.4934125988, 34805.65194348056, 35492.645073549254, 35532.64467355326, 35609.82195089021, 35646.82176589113, 7741.574213418274, 7798.8440231195345, 7837.725679601215, 7838.0, 7848.48984815988, 7363.447741419388, 7703.8844417333785, 7740.651670674833, 7751.6124193790365, 7779.572123533203, 7593.164751877289, 7613.619319034054, 7687.461877668566, 7718.305352518272, 7752.496087754306, 7626.885596716026, 7715.074191097048, 7761.534307941542, 7780.766577002699, 8000.399970002273, 7506.62466876654, 7629.8855517167285, 7645.503042302233, 7655.043119610049, 7657.885131723028, 32243.6775632243, 32422.83788581042, 32675.183120422178, 32906.0, 33418.3316333672, 2153.12798316682, 2327.3483424641126, 2338.68932447212, 2601.609758536216, 3206.214477453039, 22290.665640015413, 22649.433764155863, 23066.884665576734, 23437.88281058601, 23564.64653030206, 1843.7142242952364, 1856.545146439131, 1894.0719047666682, 1905.8284754372035, 1932.9710054349196, 199466.0, 200359.0, 201678.0, 202412.0, 205127.0, 44614.77692611516, 46480.3027954581, 47716.5228347719, 52556.21165682518, 55214.0, 50912.49087509078, 51984.740076300135, 51990.740046300285, 52513.73743131336, 52822.47177528252, 12829.23024618526, 13018.0, 13046.608601741962, 13099.607011789662, 13166.078374513692, 9837.311388202757, 9922.355046921926, 9955.0, 9955.751106222258, 9990.750231244132, 16400.75398869018, 16570.83429165693, 16599.917000415164, 16607.83392166063, 16617.252223649964, 6535.8692826143215, 6818.249992500821, 6820.6930688119155, 6876.415504682058, 6888.104546408935, 785.654312102673, 818.0938413496658, 829.5354601423222, 833.0336809301182, 916.4409710076848, 23678.28965131049, 23955.401114971915, 24070.157544485857, 24071.51856962886, 24278.27165185047, 880.823835232956, 923.7736754495191, 984.6159997600798, 985.9605615775432, 1032.2774058159318, 12396.566120185751, 12437.62687119388, 12510.437030333656, 12565.560205392767, 12624.431900564314, 251729.0, 254394.0, 259968.0, 260815.0, 261799.0, 44317.0, 44350.89122771956, 44386.778066109466, 44822.10355792866, 44919.0, 1146.4095990564865, 1149.5459293579156, 1160.2632328471482, 1171.5957994491887, 1172.8709841917382, 23290.417739555967, 23649.52700945937, 23680.0, 23732.406689832893, 23834.284971450885, 41333.1733365325, 42511.57488425076, 42526.0, 42920.141597167254, 43247.13505729931, 154907.0, 156689.0, 158240.0, 158318.20840895723, 158549.0, 24122.03511859506, 34860.82569587136, 35183.12042198863, 35781.0, 36311.09222269359, 36973.0, 37122.0, 38032.429513556766, 38155.0, 38340.808295959454, 29791.85104074466, 31351.372972539964, 31355.0, 31637.209069772518, 31699.0, 30955.535666964563, 31224.0, 31311.68688313088, 31381.05856824299, 31554.84222578964, 31183.688163118077, 32259.838700806347, 32371.51442728314, 32586.34827303488, 32604.836975815917, 25154.496910062062, 27313.86343068272, 28077.298067548476, 28132.57801132944, 28286.57570136491, 20725.481862953548, 22100.33698989033, 22191.667124992815, 22239.110435582395, 22682.773172268728], "prototype.html": [262.09576959489766, 262.8370410345586, 266.79590113563114, 270.0655731170151, 272.72727272727275, 5151.381834179894, 5179.378474583055, 5193.662411943225, 5211.739413029348, 5222.738863056851, 4989.875253118674, 5124.6925184488955, 5144.17693169093, 5165.81919632813, 5172.120739474289, 3942.467766851467, 3957.347037738784, 3966.1671049079728, 3983.302921988655, 3993.4409182714444, 3951.308521008826, 3961.0493481564363, 3962.6235507626875, 3971.86098486553, 3977.2642061218767, 3928.41073838925, 3929.3713005919058, 3930.7248492605386, 3931.6658084062747, 3958.0, 3775.3959366501367, 3830.8467661293516, 3858.5176852893387, 3883.9611603884023, 3899.5320561532512, 3299.0597679661423, 3302.2734998300334, 3315.469524876008, 3343.498475228711, 3355.429576971896, 4868.172410690191, 4943.4809345018975, 4972.328735620681, 4976.776045077981, 5019.799208031674, 4373.759443230621, 4383.912321753547, 4416.24923762961, 4423.1153769246275, 4451.532589078132, 5380.542653874425, 5380.923815236968, 5409.810656626999, 5432.29380180574, 5457.645253058538, 3596.1189508570305, 3617.149969757105, 3619.5475565554307, 3643.635636436362, 3649.379605467077, 5544.861378465571, 5629.296337957755, 5649.265595472603, 5672.432756724335, 5705.2012718219485, 3674.3018826422895, 3676.17286110623, 3689.8339574719203, 3689.9262014759556, 3726.832292546842, 3743.12036671382, 3758.605346438639, 3766.5668448128267, 3766.5856755756845, 3778.5843557208686, 4346.695731298779, 4358.084802191575, 4359.847405340861, 4368.388425620416, 4376.474823021258, 5154.252633368141, 5219.347581552306, 5369.463053694677, 5422.48486393792, 5432.619716619878, 1316.789313709802, 1350.1831392007891, 1351.425644101253, 1360.653033476477, 1366.0778974192579, 851.948883067018, 858.3176374782063, 868.7828042989253, 874.8775171475999, 876.0626130040922, 5121.564667003347, 5137.897242055213, 5152.330197074356, 5173.793048278027, 5209.426963034063, 5481.725913704299, 5535.640183388067, 5543.113101903676, 5667.518260947865, 5696.974544582015, 5220.112580861262, 5229.058769421541, 5230.555402790729, 5232.843014709565, 5233.188855727369, 3064.4637188491924, 3076.984615076955, 3127.56214130022, 3151.732102771244, 3155.637101733284, 5766.394528574523, 5791.391903850119, 5818.709064546841, 5842.912356314659, 5848.912266316009, 5759.424057594207, 5766.711664416763, 5796.739146738322, 5814.970925145347, 5825.766969321265, 5746.425357464387, 5783.19035335045, 5783.2192653992015, 5821.068629019422, 5905.291365036137, 5548.0845660465575, 5668.0364338063455, 5676.120201368794, 5684.232628595252, 5686.09022556389, 5509.586780991362, 5537.390887002507, 5541.722913854372, 5542.168674698827, 5543.695096769717, 5777.306723193244, 5792.333881603501, 5801.709914504342, 5815.2149459822385, 5875.764969401176, 3594.4428613564937, 3629.1108678373967, 3684.2631473704832, 3695.870644527536, 3718.1448266898224, 5513.393526711979, 5529.4470552945995, 5548.9722551386985, 5565.638233514808, 5576.553875690016, 5357.705326207096, 5406.594505412031, 5463.9180412294645, 5465.562754979672, 5473.67157970523, 5400.459954004568, 5432.565394768488, 5450.809221677222, 5465.863353416196, 5486.670799752028, 5308.840734777963, 5318.920216196838, 5326.748214169745, 5345.0, 5366.838994830161, 5367.865803354791, 5453.127499600045, 5467.343918729778, 5476.342838859362, 5558.555315574825, 5344.0, 5357.089294819812, 5372.838814835562, 5415.675059496442, 5432.103702889137], "yui.html": [617.4874853871287, 618.4125081172884, 631.6241836107517, 647.6599785112816, 649.1852724830337, 10723.571057157715, 11007.0, 11885.168038237327, 11929.10531710123, 11996.220245684024, 10979.066779323766, 10983.890161098387, 11027.779444411108, 11037.889621103786, 11053.336799792018, 582.2750675409121, 596.8179705189915, 728.5810658871144, 735.7351353512745, 754.2570567990525, 742.6361083069285, 745.5116898431536, 746.5446077892482, 748.6705849426262, 749.2619769527012, 760.4524742185645, 763.2482005224849, 768.0131031624364, 777.5878784244331, 780.6292011294646, 766.4366690482491, 766.5975362934448, 767.2021098058041, 773.0800347586382, 777.1529033353644, 563.9210510528488, 567.1719289836843, 568.7867049856304, 573.3206150711378, 579.122629216737, 10011.49942502872, 10105.595776168944, 10107.64623238183, 10168.034036766496, 10183.745406364826, 9520.428774273565, 9577.0, 9981.500924953723, 9994.100530952177, 10283.177345812392, 7701.807454813618, 7908.841823163562, 7915.248051435105, 7982.281594656509, 8025.117237103914, 2716.3480764616547, 2757.5725762506645, 2803.1030070377487, 2840.261532001674, 2884.4663737208684, 41065.79467102645, 41154.58845411537, 41841.0, 41873.1625367494, 41945.0, 7359.852802943911, 7467.514611550232, 7600.50596711212, 7641.541507509567, 7891.526508409514, 16009.839901601068, 16071.35714571404, 16102.838971610368, 16188.595285117966, 16249.918750406172, 5507.449255074541, 5719.7140142992685, 5736.856578585485, 5774.971125144348, 5926.496247818897, 2948.7346138847606, 2967.7329040386467, 2979.2254013956526, 2982.5824384586176, 2991.3269514359095, 2214.977850221477, 2269.1490690990877, 2278.6012447821563, 2290.6449500327476, 2296.5636529059425, 327.9032685357825, 334.69041136948226, 335.4113530753561, 336.48181800027686, 336.9208236064523, 375.7839242435556, 387.8390467955767, 441.20582950688635, 453.505678810092, 471.1542780708636, 5845.503132233723, 6191.329557244502, 6195.783147589813, 6247.187865577446, 6332.366763323631, 376.7795839433907, 478.9544993225638, 486.0788805214099, 492.7683988525387, 501.393314089948, 2962.7333539981505, 3056.770742194344, 3070.570120183176, 3097.3340731742783, 3127.56214130022, 47474.050518989425, 47745.28382074272, 48379.75810120927, 48541.0, 48682.0, 42466.15067698629, 44775.77612111918, 44889.551104488535, 45050.09899802051, 45363.773181134544, 39835.60164398377, 40742.79628601838, 41092.178156436705, 41151.0, 41380.586194138275, 6380.106785050004, 6495.707693153725, 6660.866782664417, 6768.323167683192, 6923.273056329214, 29779.553306699985, 30111.0, 30439.695603043685, 30587.08238752841, 30984.0, 37091.814540927124, 38211.80894095512, 39775.0, 40104.0, 40350.1929961405, 8551.657933682583, 8598.742037738877, 8666.566671666518, 8678.175573320525, 8994.685186018458, 8696.695615653422, 8832.968417263937, 8891.244244239311, 9105.089491050841, 9241.907580924104, 8362.749117526484, 8415.0, 8644.740657780276, 8751.824963500821, 8923.553822308728, 8366.581670916552, 8509.489430634181, 8611.095834937492, 8623.65505379803, 9135.086491351078, 8221.876671850046, 8362.66549338044, 8389.328853691568, 8405.915940840514, 9105.908940910505, 7105.729591938482, 7559.584222867795, 7559.659815308434, 7831.295183433518, 7831.921680783119, 6796.524243302922, 7081.46888983318, 7262.237465066092, 7455.4035677146785, 7804.609769511389]}, "summary": {"lowerIsBetter": false, "suite": 5520.803545225696, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5435.49279856876, "unit": "ms", "value": 5435.49279856876}, "dojo.html": {"lowerIsBetter": false, "filtered": 4522.481961783607, "unit": "ms", "value": 4522.481961783607}, "mootools.html": {"lowerIsBetter": false, "filtered": 3697.572953108197, "unit": "ms", "value": 3697.572953108197}, "ext.html": {"lowerIsBetter": false, "filtered": 15348.960745014117, "unit": "ms", "value": 15348.960745014117}, "prototype.html": {"lowerIsBetter": false, "filtered": 4060.3488093462156, "unit": "ms", "value": 4060.3488093462156}, "yui.html": {"lowerIsBetter": false, "filtered": 4997.990120216583, "unit": "ms", "value": 4997.990120216583}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1447263242, "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": "20151111073129", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}, {"talos_counters": {}, "results": {"audio-dft": [207.0, 210.0, 209.0, 210.0, 201.0, 203.0, 202.0, 204.0, 216.0, 209.0], "ai-astar": [126.0, 124.0, 140.0, 139.0, 141.0, 144.0, 132.0, 135.0, 134.0, 135.0], "imaging-gaussian-blur": [150.0, 143.0, 156.0, 155.0, 149.0, 150.0, 142.0, 150.0, 154.0, 143.0], "audio-beat-detection": [178.0, 167.0, 194.0, 205.0, 167.0, 188.0, 180.0, 163.0, 204.0, 165.0], "json-stringify-tinderbox": [82.0, 79.0, 82.0, 84.0, 86.0, 84.0, 86.0, 84.0, 85.0, 87.0], "stanford-crypto-pbkdf2": [185.0, 190.0, 191.0, 191.0, 194.0, 193.0, 191.0, 191.0, 197.0, 197.0], "json-parse-financial": [68.0, 72.0, 76.0, 79.0, 79.0, 79.0, 78.0, 87.0, 81.0, 82.0], "stanford-crypto-sha256-iterative": [81.0, 84.0, 87.0, 89.0, 93.0, 92.0, 93.0, 91.0, 92.0, 89.0], "audio-fft": [84.0, 93.0, 98.0, 147.0, 83.0, 88.0, 90.0, 91.0, 125.0, 83.0], "imaging-darkroom": [156.0, 156.0, 164.0, 162.0, 156.0, 157.0, 156.0, 164.0, 163.0, 156.0], "stanford-crypto-ccm": [159.0, 168.0, 163.0, 175.0, 163.0, 176.0, 163.0, 166.0, 164.0, 163.0], "audio-oscillator": [103.0, 107.0, 154.0, 110.0, 114.0, 115.0, 149.0, 108.0, 110.0, 154.0], "stanford-crypto-aes": [103.0, 107.0, 113.0, 111.0, 114.0, 110.0, 108.0, 107.0, 112.0, 109.0], "imaging-desaturate": [128.0, 138.0, 133.0, 133.0, 133.0, 133.0, 136.0, 134.0, 133.0, 128.0]}, "summary": {"lowerIsBetter": true, "suite": 1903.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 98.2, "unit": "ms", "value": 98.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 192.0, "unit": "ms", "value": 192.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 181.1, "unit": "ms", "value": 181.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 166.0, "unit": "ms", "value": 166.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 159.0, "unit": "ms", "value": 159.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 78.1, "unit": "ms", "value": 78.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 122.4, "unit": "ms", "value": 122.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 135.0, "unit": "ms", "value": 135.0}, "audio-dft": {"lowerIsBetter": true, "filtered": 207.1, "unit": "ms", "value": 207.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 89.1, "unit": "ms", "value": 89.1}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.9, "unit": "ms", "value": 83.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 149.2, "unit": "ms", "value": 149.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 132.9, "unit": "ms", "value": 132.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1447263242, "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": "20151111073129", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [237.36055067647757], "Encrypt": [386.24951718810354], "NavierStokes": [6823.1292517006805], "Decrypt": [6836.734693877551], "Splay": [801.924619085806], "Richards": [203.5002035002035], "RegExp": [34542.372881355936], "Earley": [1096.4912280701753], "Boyer": [15194.029850746268], "RayTrace": [1342.2818791946308]}, "summary": {"lowerIsBetter": false, "suite": 16099.510812288057, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 278.55513399999995, "unit": "score", "value": 278.55513399999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 689.1426090000001, "unit": "score", "value": 689.1426090000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 217.49551345962115, "unit": "score", "value": 217.49551345962115}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.93393731343284, "unit": "score", "value": 38.93393731343284}, "Splay": {"lowerIsBetter": false, "filtered": 101.619277, "unit": "score", "value": 101.619277}, "RegExp": {"lowerIsBetter": false, "filtered": 26.372971050049042, "unit": "score", "value": 26.372971050049042}, "Richards": {"lowerIsBetter": false, "filtered": 173.47402800000006, "unit": "score", "value": 173.47402800000006}, "Earley": {"lowerIsBetter": false, "filtered": 607.8142559999999, "unit": "score", "value": 607.8142559999999}, "Boyer": {"lowerIsBetter": false, "filtered": 43.86347838899805, "unit": "score", "value": 43.86347838899805}, "RayTrace": {"lowerIsBetter": false, "filtered": 551.291805, "unit": "score", "value": 551.291805}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0099.e"}, "testrun": {"date": 1447263242, "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": "20151111073129", "branch": "Fx-Team", "revision": "e402ff476e1b9ff5764aeec44442ab3213c2efc6"}}] 09:54:21 INFO - RETURN: dromaeo_css: 5520.80 09:54:21 INFO - RETURN: kraken: 1903.40 09:54:21 INFO - RETURN: v8_7: 16099.51 09:54:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "16099.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1903.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5520.80"}}} 09:54:21 INFO - Return code: 0 09:54:21 INFO - # TBPL SUCCESS # 09:54:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:21 INFO - 2015-11-11 09:54:21.699 screenresolution[1669:11084] starting screenresolution argv=screenresolution get 09:54:21 INFO - 2015-11-11 09:54:21.703 screenresolution[1669:11084] Display 0: 1600x1200x32@60 09:54:21 INFO - 2015-11-11 09:54:21.709 screenresolution[1670:11088] starting screenresolution argv=screenresolution list 09:54:21 INFO - Available Modes on Display 0 09:54:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:21 INFO - Intel HD Graphics 3000: 09:54:21 INFO - Chipset Model: Intel HD Graphics 3000 09:54:21 INFO - Type: GPU 09:54:21 INFO - Bus: Built-In 09:54:21 INFO - VRAM (Total): 512 MB 09:54:21 INFO - VRAM (Dynamic, Max): 10 09:54:21 INFO - Vendor: Intel (0x8086) 09:54:21 INFO - Device ID: 0x0116 09:54:21 INFO - Revision ID: 0x0009 09:54:21 INFO - Displays: 09:54:21 INFO - Display: 09:54:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:21 INFO - Display Serial Number: 1600x1200 60 09:54:21 INFO - Main Display: Yes 09:54:21 INFO - Mirror: Off 09:54:21 INFO - Online: Yes 09:54:21 INFO - Rotation: Supported 09:54:21 INFO - Return code: 0 09:54:21 INFO - Running post-action listener: _resource_record_post_action 09:54:21 INFO - Running post-run listener: _resource_record_post_run 09:54:23 INFO - Total resource usage - Wall time: 1263s; CPU: 30.0%; Read bytes: 39465984; Write bytes: 692045824; Read time: 4949; Write time: 63219 09:54:23 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 339853824; Write bytes: 335222784; Read time: 37125; Write time: 7255 09:54:23 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 37348352; Write bytes: 345636864; Read time: 4535; Write time: 55174 09:54:23 INFO - Running post-run listener: _upload_blobber_files 09:54:23 INFO - Blob upload gear active. 09:54:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:54:23 INFO - Copying logs to upload dir... 09:54:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=2200.532882 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 36 mins, 40 secs) (at 2015-11-11 09:54:23.167443) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:54:23.171092) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010421 build_url: 'https://queue.taskcluster.net/v1/task/tAxaQcTjSK6KUdUAkXU6Jw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 09:54:23.198826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:54:23.199189) ========= 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.9LfSd22sUx/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.WqGqRFGh6i/Listeners TMPDIR=/var/folders/b9/sx1vz_ys4ysffmsmlss6199c00000w/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.005850 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 09:54:23.250122) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 09:54:23.250470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 09:54:23.250959) ========= ========= Total master_lag: 0.29 =========