builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0101 starttime: 1447358874.12 results: success (0) buildid: 20151112102147 builduid: e7b7c8acbe7f4490bf480e72b84433d6 revision: 6aff4aa8f3dee8b902434e572b65b4eff40d00dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.120523) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.121035) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.121343) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006040 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.184757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.185120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.217828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.218213) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.015738 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.266615) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.266928) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.267292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.267576) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-12 12:07:54-- 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% 16.9M=0.001s 2015-11-12 12:07:54 (16.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.447460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.447823) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.165755 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:54.628283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 12:07:54.628744) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6aff4aa8f3dee8b902434e572b65b4eff40d00dc --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 6aff4aa8f3dee8b902434e572b65b4eff40d00dc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-12 12:07:54,717 truncating revision to first 12 chars 2015-11-12 12:07:54,718 Setting DEBUG logging. 2015-11-12 12:07:54,718 attempt 1/10 2015-11-12 12:07:54,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6aff4aa8f3de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 12:07:55,538 unpacking tar archive at: fx-team-6aff4aa8f3de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-12 12:07:55.736201) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:55.736619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:55.750276) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:55.750864) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 12:07:55.751617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-12 12:07:55.752115) ========= /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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 12:07:56 INFO - MultiFileLogger online at 20151112 12:07:56 in /builds/slave/test 12:07:56 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 12:07:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:07:56 INFO - {'append_to_log': False, 12:07:56 INFO - 'base_work_dir': '/builds/slave/test', 12:07:56 INFO - 'blob_upload_branch': 'Fx-Team', 12:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:07:56 INFO - 'branch': 'Fx-Team', 12:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:07:56 INFO - 'config_files': ('talos/mac_config.py',), 12:07:56 INFO - 'default_actions': ('clobber', 12:07:56 INFO - 'read-buildbot-config', 12:07:56 INFO - 'download-and-extract', 12:07:56 INFO - 'populate-webroot', 12:07:56 INFO - 'create-virtualenv', 12:07:56 INFO - 'install', 12:07:56 INFO - 'run-tests'), 12:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:07:56 INFO - 'download_minidump_stackwalk': True, 12:07:56 INFO - 'download_symbols': 'ondemand', 12:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:07:56 INFO - 'installer_path': 'installer.exe', 12:07:56 INFO - 'log_level': 'info', 12:07:56 INFO - 'log_name': 'talos', 12:07:56 INFO - 'log_to_console': True, 12:07:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:07:56 INFO - 'opt_config_files': (), 12:07:56 INFO - 'pip_index': False, 12:07:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:07:56 INFO - 'cmd': ('bash', 12:07:56 INFO - '-c', 12:07:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:07:56 INFO - 'enabled': True, 12:07:56 INFO - 'halt_on_failure': False, 12:07:56 INFO - 'name': 'check_screen_resolution'},), 12:07:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:07:56 INFO - 'cmd': ('bash', 12:07:56 INFO - '-c', 12:07:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:07:56 INFO - 'enabled': True, 12:07:56 INFO - 'halt_on_failure': False, 12:07:56 INFO - 'name': 'check_screen_resolution'},), 12:07:56 INFO - 'run_cmd_checks_enabled': True, 12:07:56 INFO - 'sps_profile': False, 12:07:56 INFO - 'sps_profile_interval': 0, 12:07:56 INFO - 'suite': 'dromaeojs-e10s', 12:07:56 INFO - 'system_bits': '64', 12:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:07:56 INFO - 'title': 't-yosemite-r5-0101', 12:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:07:56 INFO - 'use_talos_json': True, 12:07:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:07:56 INFO - 'work_dir': 'build'} 12:07:56 INFO - ##### 12:07:56 INFO - ##### Running clobber step. 12:07:56 INFO - ##### 12:07:56 INFO - Running pre-action listener: _resource_record_pre_action 12:07:56 INFO - Running main action method: clobber 12:07:56 INFO - rmtree: /builds/slave/test/build 12:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:01 INFO - Running post-action listener: _resource_record_post_action 12:08:01 INFO - ##### 12:08:01 INFO - ##### Running read-buildbot-config step. 12:08:01 INFO - ##### 12:08:01 INFO - Running pre-action listener: _resource_record_pre_action 12:08:01 INFO - Running main action method: read_buildbot_config 12:08:01 INFO - Using buildbot properties: 12:08:01 INFO - { 12:08:01 INFO - "properties": { 12:08:01 INFO - "buildnumber": 30, 12:08:01 INFO - "product": "firefox", 12:08:01 INFO - "script_repo_revision": "production", 12:08:01 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 12:08:01 INFO - "repository": "", 12:08:01 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 12:08:01 INFO - "buildid": "20151112102147", 12:08:01 INFO - "slavename": "t-yosemite-r5-0101", 12:08:01 INFO - "pgo_build": "False", 12:08:01 INFO - "basedir": "/builds/slave/test", 12:08:01 INFO - "project": "", 12:08:01 INFO - "platform": "yosemite", 12:08:01 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:08:01 INFO - "slavebuilddir": "test", 12:08:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:08:01 INFO - "branch": "fx-team", 12:08:01 INFO - "repo_path": "integration/fx-team", 12:08:01 INFO - "stage_platform": "macosx64", 12:08:01 INFO - "builduid": "e7b7c8acbe7f4490bf480e72b84433d6", 12:08:01 INFO - "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc" 12:08:01 INFO - }, 12:08:01 INFO - "sourcestamp": { 12:08:01 INFO - "repository": "", 12:08:01 INFO - "hasPatch": false, 12:08:01 INFO - "project": "", 12:08:01 INFO - "branch": "fx-team-macosx64-talos", 12:08:01 INFO - "changes": [ 12:08:01 INFO - { 12:08:01 INFO - "category": null, 12:08:01 INFO - "files": [ 12:08:01 INFO - { 12:08:01 INFO - "url": null, 12:08:01 INFO - "name": "https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:08:01 INFO - } 12:08:01 INFO - ], 12:08:01 INFO - "repository": "", 12:08:01 INFO - "rev": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc", 12:08:01 INFO - "who": "bgrinstead@mozilla.com", 12:08:01 INFO - "when": 1447358340, 12:08:01 INFO - "number": 6654536, 12:08:01 INFO - "comments": "Bug 1173397 - Refactor devtools toolbar button code. r=bgrins", 12:08:01 INFO - "project": "", 12:08:01 INFO - "at": "Thu 12 Nov 2015 11:59:00", 12:08:01 INFO - "branch": "fx-team-macosx64-talos", 12:08:01 INFO - "revlink": "", 12:08:01 INFO - "properties": [ 12:08:01 INFO - [ 12:08:01 INFO - "buildid", 12:08:01 INFO - "20151112102147", 12:08:01 INFO - "Change" 12:08:01 INFO - ], 12:08:01 INFO - [ 12:08:01 INFO - "builduid", 12:08:01 INFO - "e7b7c8acbe7f4490bf480e72b84433d6", 12:08:01 INFO - "Change" 12:08:01 INFO - ], 12:08:01 INFO - [ 12:08:01 INFO - "pgo_build", 12:08:01 INFO - "False", 12:08:01 INFO - "Change" 12:08:01 INFO - ] 12:08:01 INFO - ], 12:08:01 INFO - "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc" 12:08:01 INFO - } 12:08:01 INFO - ], 12:08:01 INFO - "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc" 12:08:01 INFO - } 12:08:01 INFO - } 12:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:08:01 INFO - Running post-action listener: _resource_record_post_action 12:08:01 INFO - ##### 12:08:01 INFO - ##### Running download-and-extract step. 12:08:01 INFO - ##### 12:08:01 INFO - Running pre-action listener: _resource_record_pre_action 12:08:01 INFO - Running main action method: download_and_extract 12:08:01 INFO - mkdir: /builds/slave/test/build/tests 12:08: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')]} 12:08:01 INFO - https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/test_packages.json 12:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/test_packages.json 12:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:08:02 INFO - Downloaded 1149 bytes. 12:08:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:08:02 INFO - Using the following test package requirements: 12:08:02 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:08:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:08:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'jsshell-mac.zip'], 12:08:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:08:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:08:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:08:02 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:08:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:08:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:08:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:08:02 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:08:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:08:02 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')]} 12:08:02 INFO - https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:03 INFO - Downloaded 17454959 bytes. 12:08:03 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 12:08:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:08:12 INFO - Return code: 0 12:08:12 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 12:08: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')]} 12:08:12 INFO - https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:08:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:13 INFO - Downloaded 17454959 bytes. 12:08:13 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 12:08:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:08:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:08:20 INFO - Return code: 0 12:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:20 INFO - https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:21 INFO - Downloaded 11131693 bytes. 12:08:21 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 12:08:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:08:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:08:22 INFO - Return code: 0 12:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:22 INFO - https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/USG53aW_Q6uJu_lD_WcT3w/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 12:08:25 INFO - Downloaded 108703579 bytes. 12:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:08:25 INFO - mkdir: /builds/slave/test/properties 12:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 12:08:25 INFO - Contents: 12:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:08:25 INFO - Running post-action listener: _resource_record_post_action 12:08:25 INFO - Running post-action listener: set_extra_try_arguments 12:08:25 INFO - ##### 12:08:25 INFO - ##### Running populate-webroot step. 12:08:25 INFO - ##### 12:08:25 INFO - Running pre-action listener: _resource_record_pre_action 12:08:25 INFO - Running main action method: populate_webroot 12:08:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:08:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:08:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:08:25 INFO - '../fennec_ids.txt'], 12:08:25 INFO - 'tests': ['tcheck2']}, 12:08:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:08:25 INFO - '--tppagecycles', 12:08:25 INFO - '7'], 12:08:25 INFO - 'tests': ['tsvgm']}}, 12:08:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:08:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:08:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:08:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:08:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'tests': ['damp', 'tps']}, 12:08:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['damp', 'tps']}, 12:08:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:08:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:08:25 INFO - 'other': {'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'other_l64': {'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'other_nol64': {'tests': ['a11yr', 12:08:25 INFO - 'ts_paint', 12:08:25 INFO - 'tpaint', 12:08:25 INFO - 'sessionrestore', 12:08:25 INFO - 'sessionrestore_no_auto_restore']}, 12:08:25 INFO - 'svgr': {'tests': ['tsvgx', 12:08:25 INFO - 'tsvgr_opacity', 12:08:25 INFO - 'tart', 12:08:25 INFO - 'tscrollx', 12:08:25 INFO - 'cart']}, 12:08:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['tsvgx', 12:08:25 INFO - 'tsvgr_opacity', 12:08:25 INFO - 'tart', 12:08:25 INFO - 'tscrollx', 12:08:25 INFO - 'cart']}, 12:08:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'tests': ['tp5o']}, 12:08:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'talos_options': ['--e10s'], 12:08:25 INFO - 'tests': ['tp5o']}, 12:08:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'talos_options': ['--xperf_path', 12:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:25 INFO - 'tests': ['tp5n']}, 12:08:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:25 INFO - 'talos_options': ['--e10s', 12:08:25 INFO - '--xperf_path', 12:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:25 INFO - 'tests': ['tp5n']}}, 12:08:25 INFO - 'talos.zip': {'path': '', 12:08:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:08:25 INFO - Running post-action listener: _resource_record_post_action 12:08:25 INFO - ##### 12:08:25 INFO - ##### Running create-virtualenv step. 12:08:25 INFO - ##### 12:08:25 INFO - Running pre-action listener: _resource_record_pre_action 12:08:25 INFO - Running main action method: create_virtualenv 12:08:25 INFO - Creating virtualenv /builds/slave/test/build/venv 12:08:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:08:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:08:26 INFO - Using real prefix '/tools/python27' 12:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:08:27 INFO - Installing distribute.............................................................................................................................................................................................done. 12:08:30 INFO - Installing pip.................done. 12:08:30 INFO - Return code: 0 12:08:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:30 INFO - 'HOME': '/Users/cltbld', 12:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:30 INFO - 'LOGNAME': 'cltbld', 12:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:30 INFO - 'MOZ_NO_REMOTE': '1', 12:08:30 INFO - 'NO_EM_RESTART': '1', 12:08:30 INFO - 'PAGER': '/bin/cat', 12:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:30 INFO - 'PWD': '/builds/slave/test', 12:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:30 INFO - 'SHELL': '/bin/bash', 12:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:30 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:30 INFO - 'USER': 'cltbld', 12:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:30 INFO - 'XPC_FLAGS': '0x0', 12:08:30 INFO - 'XPC_SERVICE_NAME': '0', 12:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:08:31 INFO - Cleaning up... 12:08:31 INFO - Return code: 0 12:08:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:31 INFO - 'HOME': '/Users/cltbld', 12:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:31 INFO - 'LOGNAME': 'cltbld', 12:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:31 INFO - 'MOZ_NO_REMOTE': '1', 12:08:31 INFO - 'NO_EM_RESTART': '1', 12:08:31 INFO - 'PAGER': '/bin/cat', 12:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:31 INFO - 'PWD': '/builds/slave/test', 12:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:31 INFO - 'SHELL': '/bin/bash', 12:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:31 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:31 INFO - 'USER': 'cltbld', 12:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:31 INFO - 'XPC_FLAGS': '0x0', 12:08:31 INFO - 'XPC_SERVICE_NAME': '0', 12:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:31 INFO - Downloading/unpacking psutil>=0.7.1 12:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:08:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:08:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:34 INFO - Installing collected packages: psutil 12:08:34 INFO - Running setup.py install for psutil 12:08:34 INFO - building 'psutil._psutil_osx' extension 12:08:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:08:36 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 12:08:36 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 12:08:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:08:37 INFO - building 'psutil._psutil_posix' extension 12:08:37 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 12:08:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:08:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:08:37 INFO - ^ 12:08:37 INFO - 1 warning generated. 12:08:37 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 12:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:37 INFO - Successfully installed psutil 12:08:37 INFO - Cleaning up... 12:08:37 INFO - Return code: 0 12:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:08:37 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')]} 12:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:37 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')]} 12:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:37 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 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:37 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 12:08:37 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 12:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:37 INFO - 'HOME': '/Users/cltbld', 12:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:37 INFO - 'LOGNAME': 'cltbld', 12:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:37 INFO - 'MOZ_NO_REMOTE': '1', 12:08:37 INFO - 'NO_EM_RESTART': '1', 12:08:37 INFO - 'PAGER': '/bin/cat', 12:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:37 INFO - 'PWD': '/builds/slave/test', 12:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:37 INFO - 'SHELL': '/bin/bash', 12:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:37 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:37 INFO - 'USER': 'cltbld', 12:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:37 INFO - 'XPC_FLAGS': '0x0', 12:08:37 INFO - 'XPC_SERVICE_NAME': '0', 12:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:08:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:08:40 INFO - Installing collected packages: mozsystemmonitor 12:08:40 INFO - Running setup.py install for mozsystemmonitor 12:08:41 INFO - Successfully installed mozsystemmonitor 12:08:41 INFO - Cleaning up... 12:08:41 INFO - Return code: 0 12:08:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:41 INFO - 'HOME': '/Users/cltbld', 12:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:41 INFO - 'LOGNAME': 'cltbld', 12:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:41 INFO - 'MOZ_NO_REMOTE': '1', 12:08:41 INFO - 'NO_EM_RESTART': '1', 12:08:41 INFO - 'PAGER': '/bin/cat', 12:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:41 INFO - 'PWD': '/builds/slave/test', 12:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:41 INFO - 'SHELL': '/bin/bash', 12:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:41 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:41 INFO - 'USER': 'cltbld', 12:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:41 INFO - 'XPC_FLAGS': '0x0', 12:08:41 INFO - 'XPC_SERVICE_NAME': '0', 12:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:08:41 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 12:08:41 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 12:08:41 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 12:08:41 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 12:08:41 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 12:08:41 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 12:08:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:08:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:08:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:45 INFO - Downloading docopt-0.6.1.tar.gz 12:08:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:08:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:08:45 INFO - Running setup.py install for blobuploader 12:08:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:08:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:08:45 INFO - Running setup.py install for requests 12:08:46 INFO - Running setup.py install for docopt 12:08:46 INFO - Successfully installed blobuploader requests docopt 12:08:46 INFO - Cleaning up... 12:08:46 INFO - Return code: 0 12:08:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:46 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 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:46 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 12:08:46 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 12:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:46 INFO - 'HOME': '/Users/cltbld', 12:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:46 INFO - 'LOGNAME': 'cltbld', 12:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:46 INFO - 'MOZ_NO_REMOTE': '1', 12:08:46 INFO - 'NO_EM_RESTART': '1', 12:08:46 INFO - 'PAGER': '/bin/cat', 12:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:46 INFO - 'PWD': '/builds/slave/test', 12:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:46 INFO - 'SHELL': '/bin/bash', 12:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:46 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:46 INFO - 'USER': 'cltbld', 12:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:46 INFO - 'XPC_FLAGS': '0x0', 12:08:46 INFO - 'XPC_SERVICE_NAME': '0', 12:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:46 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-nXRm8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:46 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-_a5Fpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:46 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-MD4ruz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-2kagUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-onWhxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-OwRlgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-I14bAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-YhBDlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-IN1LpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-H5EMW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:47 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-CV0Lws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-gakXLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-WHxN__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-O7PJmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-2ehCHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-Lg4zpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:48 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-ALVNEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:08:48 INFO - Running setup.py install for manifestparser 12:08:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:08:49 INFO - Running setup.py install for mozcrash 12:08:49 INFO - Running setup.py install for mozdebug 12:08:49 INFO - Running setup.py install for mozdevice 12:08:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:08:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:08:49 INFO - Running setup.py install for mozfile 12:08:49 INFO - Running setup.py install for mozhttpd 12:08:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:08:49 INFO - Running setup.py install for mozinfo 12:08:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Running setup.py install for mozInstall 12:08:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Running setup.py install for mozleak 12:08:50 INFO - Running setup.py install for mozlog 12:08:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Running setup.py install for moznetwork 12:08:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:08:50 INFO - Running setup.py install for mozprocess 12:08:51 INFO - Running setup.py install for mozprofile 12:08:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Running setup.py install for mozrunner 12:08:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Running setup.py install for mozscreenshot 12:08:51 INFO - Running setup.py install for moztest 12:08:51 INFO - Running setup.py install for mozversion 12:08:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:08:51 INFO - Cleaning up... 12:08:51 INFO - Return code: 0 12:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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', '-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 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:51 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 12:08:51 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 12:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:51 INFO - 'HOME': '/Users/cltbld', 12:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:51 INFO - 'LOGNAME': 'cltbld', 12:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:51 INFO - 'MOZ_NO_REMOTE': '1', 12:08:51 INFO - 'NO_EM_RESTART': '1', 12:08:51 INFO - 'PAGER': '/bin/cat', 12:08:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:51 INFO - 'PWD': '/builds/slave/test', 12:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:51 INFO - 'SHELL': '/bin/bash', 12:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:51 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:51 INFO - 'USER': 'cltbld', 12:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:51 INFO - 'XPC_FLAGS': '0x0', 12:08:51 INFO - 'XPC_SERVICE_NAME': '0', 12:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-I4hBFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:52 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)) 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-lC08Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:52 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)) 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-vUUO5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:52 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)) 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-9P5too-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:52 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)) 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-gGEzzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:52 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)) 12:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:52 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-tekeF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-QYA5Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-4aEy4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-rtHjRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-GN7F0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-BTyGpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-zV0VLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:53 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)) 12:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:53 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-HUiKtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:54 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-4dlyEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:54 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-52Tcgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:54 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-HZwK9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:54 INFO - Running setup.py (path:/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/pip-X2BAAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:54 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)) 12:08:54 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)) 12:08:54 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)) 12:08:54 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)) 12:08:54 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)) 12:08:54 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)) 12:08:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:08:54 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 12:08:54 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 12:08:54 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 12:08:54 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 12:08:54 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 12:08:54 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 12:08:57 INFO - Downloading blessings-1.5.1.tar.gz 12:08:57 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 12:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:08:57 INFO - Installing collected packages: blessings 12:08:57 INFO - Running setup.py install for blessings 12:08:57 INFO - Successfully installed blessings 12:08:57 INFO - Cleaning up... 12:08:57 INFO - Return code: 0 12:08:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:57 INFO - Reading from file tmpfile_stdout 12:08:57 INFO - Current package versions: 12:08:57 INFO - blessings == 1.5.1 12:08:57 INFO - blobuploader == 1.2.4 12:08:57 INFO - docopt == 0.6.1 12:08:57 INFO - manifestparser == 1.1 12:08:57 INFO - mozInstall == 1.12 12:08:57 INFO - mozcrash == 0.16 12:08:57 INFO - mozdebug == 0.1 12:08:57 INFO - mozdevice == 0.47 12:08:57 INFO - mozfile == 1.2 12:08:57 INFO - mozhttpd == 0.7 12:08:57 INFO - mozinfo == 0.9 12:08:57 INFO - mozleak == 0.1 12:08:57 INFO - mozlog == 3.0 12:08:57 INFO - moznetwork == 0.27 12:08:57 INFO - mozprocess == 0.22 12:08:57 INFO - mozprofile == 0.27 12:08:57 INFO - mozrunner == 6.11 12:08:57 INFO - mozscreenshot == 0.1 12:08:57 INFO - mozsystemmonitor == 0.0 12:08:57 INFO - moztest == 0.7 12:08:57 INFO - mozversion == 1.4 12:08:57 INFO - psutil == 3.1.1 12:08:57 INFO - requests == 1.2.3 12:08:57 INFO - wsgiref == 0.1.2 12:08:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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', '-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 0x100b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc81b490e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, '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.3XJ8Zuulz3/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.9O4UONWck0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:08:57 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 12:08:57 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 12:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:57 INFO - 'HOME': '/Users/cltbld', 12:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:57 INFO - 'LOGNAME': 'cltbld', 12:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:57 INFO - 'MOZ_NO_REMOTE': '1', 12:08:57 INFO - 'NO_EM_RESTART': '1', 12:08:57 INFO - 'PAGER': '/bin/cat', 12:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:57 INFO - 'PWD': '/builds/slave/test', 12:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:57 INFO - 'SHELL': '/bin/bash', 12:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:08:57 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:57 INFO - 'USER': 'cltbld', 12:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:57 INFO - 'XPC_FLAGS': '0x0', 12:08:57 INFO - 'XPC_SERVICE_NAME': '0', 12:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 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)) 12:08:58 INFO - Cleaning up... 12:08:58 INFO - Return code: 0 12:08:58 INFO - Running post-action listener: _resource_record_post_action 12:08:58 INFO - Running post-action listener: _start_resource_monitoring 12:08:58 INFO - Starting resource monitoring. 12:08:58 INFO - ##### 12:08:58 INFO - ##### Running install step. 12:08:58 INFO - ##### 12:08:58 INFO - Running pre-action listener: _resource_record_pre_action 12:08:58 INFO - Running main action method: install 12:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:58 INFO - Reading from file tmpfile_stdout 12:08:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:08:58 INFO - Reading from file tmpfile_stdout 12:08:58 INFO - Output received: 12:08:58 INFO - Usage: mozinstall [options] installer 12:08:58 INFO - Options: 12:08:58 INFO - -h, --help show this help message and exit 12:08:58 INFO - -d DEST, --destination=DEST 12:08:58 INFO - Directory to install application into. [default: 12:08:58 INFO - "/builds/slave/test"] 12:08:58 INFO - --app=APP Application being installed. [default: firefox] 12:08:58 INFO - mkdir: /builds/slave/test/build/application 12:08:58 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'] 12:08:58 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 12:09:38 INFO - Reading from file tmpfile_stdout 12:09:38 INFO - Output received: 12:09:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:09:38 INFO - Running post-action listener: _resource_record_post_action 12:09:38 INFO - ##### 12:09:38 INFO - ##### Running run-tests step. 12:09:38 INFO - ##### 12:09:38 INFO - Running pre-action listener: _resource_record_pre_action 12:09:38 INFO - Running main action method: run_tests 12:09:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:38 INFO - 2015-11-12 12:09:38.460 screenresolution[1621:7544] starting screenresolution argv=screenresolution get 12:09:38 INFO - 2015-11-12 12:09:38.463 screenresolution[1621:7544] Display 0: 1600x1200x32@60 12:09:38 INFO - 2015-11-12 12:09:38.470 screenresolution[1622:7546] starting screenresolution argv=screenresolution list 12:09:38 INFO - Available Modes on Display 0 12:09:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:38 INFO - Intel HD Graphics 3000: 12:09:38 INFO - Chipset Model: Intel HD Graphics 3000 12:09:38 INFO - Type: GPU 12:09:38 INFO - Bus: Built-In 12:09:38 INFO - VRAM (Total): 512 MB 12:09:38 INFO - VRAM (Dynamic, Max): 10 12:09:38 INFO - Vendor: Intel (0x8086) 12:09:38 INFO - Device ID: 0x0116 12:09:38 INFO - Revision ID: 0x0009 12:09:38 INFO - Displays: 12:09:38 INFO - Display: 12:09:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:38 INFO - Display Serial Number: 1600x1200 60 12:09:38 INFO - Main Display: Yes 12:09:38 INFO - Mirror: Off 12:09:38 INFO - Online: Yes 12:09:38 INFO - Rotation: Supported 12:09:38 INFO - Return code: 0 12:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:38 INFO - Python 2.7.3 12:09:38 INFO - Return code: 0 12:09:38 INFO - grabbing minidump binary from tooltool 12:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:09:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a879f0>, '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 0x1007e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a7b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:09:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:09:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:38 INFO - Return code: 0 12:09:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:38 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/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] in /builds/slave/test/build 12:09:38 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/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0101 --webServer localhost 12:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3XJ8Zuulz3/Render', 12:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:38 INFO - 'HOME': '/Users/cltbld', 12:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:38 INFO - 'LOGNAME': 'cltbld', 12:09:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:38 INFO - 'MOZ_NO_REMOTE': '1', 12:09:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:38 INFO - 'NO_EM_RESTART': '1', 12:09:38 INFO - 'PAGER': '/bin/cat', 12:09:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:38 INFO - 'PWD': '/builds/slave/test', 12:09:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:38 INFO - 'SHELL': '/bin/bash', 12:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9O4UONWck0/Listeners', 12:09:38 INFO - 'TMPDIR': '/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/', 12:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:38 INFO - 'USER': 'cltbld', 12:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:38 INFO - 'XPC_FLAGS': '0x0', 12:09:38 INFO - 'XPC_SERVICE_NAME': '0', 12:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 12:09:38 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/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0101', '--webServer', 'localhost'] with output_timeout 3600 12:09:39 INFO - mozversion INFO | application_buildid: 20151112102147 12:09:39 INFO - mozversion INFO | application_changeset: 6aff4aa8f3dee8b902434e572b65b4eff40d00dc 12:09:39 INFO - mozversion INFO | application_display_name: Nightly 12:09:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:39 INFO - mozversion INFO | application_name: Firefox 12:09:39 INFO - mozversion INFO | application_remotingname: firefox 12:09:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:09:39 INFO - mozversion INFO | application_vendor: Mozilla 12:09:39 INFO - mozversion INFO | application_version: 45.0a1 12:09:39 INFO - mozversion INFO | platform_buildid: 20151112102147 12:09:39 INFO - mozversion INFO | platform_changeset: 6aff4aa8f3dee8b902434e572b65b4eff40d00dc 12:09:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:09:39 INFO - mozversion INFO | platform_version: 45.0a1 12:09:39 INFO - 2015-11-12 12:09:39,228 DEBUG : using testdate: 1447358979 12:09:39 INFO - 2015-11-12 12:09:39,228 DEBUG : actual date: 1447358979 12:09:39 INFO - 2015-11-12 12:09:39,237 INFO : starting webserver on 'localhost:49265' 12:09:39 INFO - 2015-11-12 12:09:39,239 INFO : Starting test suite t-yosemite-r5-0101.e 12:09:39 INFO - 2015-11-12 12:09:39,239 INFO : Starting test dromaeo_css 12:09:39 INFO - 2015-11-12 12:09:39,239 DEBUG : operating with platform_type : mac_ 12:09:39 INFO - 2015-11-12 12:09:39,240 INFO : Initialising browser for dromaeo_css test... 12:09:39 INFO - 2015-11-12 12:09:39,269 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpc_hZK3/profile http://localhost:49265/getInfo.html 12:09:44 INFO - 2015-11-12 12:09:44,551 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:09:44 INFO - 2015-11-12 12:09:44,552 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:09:44 INFO - 2015-11-12 12:09:44,552 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:09:44 INFO - 2015-11-12 12:09:44,552 DEBUG : BROWSER_OUTPUT: __metrics 12:09:45 INFO - 2015-11-12 12:09:45,257 INFO : Browser initialized. 12:09:45 INFO - 2015-11-12 12:09:45,258 INFO : Running cycle 1/1 for dromaeo_css test... 12:09:45 INFO - 2015-11-12 12:09:45,258 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmpc_hZK3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:09:57 INFO - 2015-11-12 12:09:57,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 240766976 12:09:57 INFO - 2015-11-12 12:09:57,587 DEBUG : BROWSER_OUTPUT: 12:10:47 INFO - 2015-11-12 12:10:47,458 DEBUG : BROWSER_OUTPUT: 1447359047456 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] 12:12:58 INFO - 2015-11-12 12:12:58,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 12:12:59 INFO - 2015-11-12 12:12:59,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 265424896 12:12:59 INFO - 2015-11-12 12:12:59,540 DEBUG : BROWSER_OUTPUT: 12:16:01 INFO - 2015-11-12 12:16:01,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 12:16:02 INFO - 2015-11-12 12:16:02,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 271405056 12:16:02 INFO - 2015-11-12 12:16:02,184 DEBUG : BROWSER_OUTPUT: 12:19:03 INFO - 2015-11-12 12:19:03,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 12:19:04 INFO - 2015-11-12 12:19:04,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 272879616 12:19:04 INFO - 2015-11-12 12:19:04,565 DEBUG : BROWSER_OUTPUT: 12:22:06 INFO - 2015-11-12 12:22:06,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 12:22:06 INFO - 2015-11-12 12:22:06,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 278896640 12:22:06 INFO - 2015-11-12 12:22:06,886 DEBUG : BROWSER_OUTPUT: 12:25:09 INFO - 2015-11-12 12:25:09,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 12:25:10 INFO - 2015-11-12 12:25:10,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 283275264 12:25:10 INFO - 2015-11-12 12:25:10,313 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 12:28:12 INFO - 2015-11-12 12:28:12,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 288010240 12:28:12 INFO - 2015-11-12 12:28:12,924 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,924 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:28:12 INFO - 2015-11-12 12:28:12,924 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:28:12 INFO - 2015-11-12 12:28:12,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:28:12 INFO - 2015-11-12 12:28:12,925 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:28:12 INFO - 2015-11-12 12:28:12,925 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2721.129238643634;2728.31792051987;2749.2577004208856;2795.776337892969;2803.9859800700992;4467.731936083833;4592.311153327003;4612.354270402142;4684.086603112394;4807.471178170407;4643.16423043852;4667.696599721015;4672.182368085589;4713;4734.976325118379;4317.956820431803;4357.869263922072;4453.265211240141;4528.705634133771;4536.954630453686;4388.956110438887;4398.670099742516;4413.470383553978;4413.7351758894565;4421.204183247014;4440.089781594766;4443.777811109448;4445.555444455561;4447.799849006787;4480.14877173336;4245.405643209953;4278.187144442546;4339.47926248849;4404.163208990313;4441.866743997685;4432.357308190327;4444.488883778375;4460.553944605514;4462.085272519158;4529.207388706963;4416.911661766779;4589.655775816794;4631.884202894921;4668.229742092551;4703.482616912137;4666.0901124280435;4781.091592597395;4787.904241915142;4810.735409552473;5034.798608055673;4993.725345106018;5121.820736274212;5129.051125541787;5143.871403214912;5152.304438900738;4577.176108300538;4594.310853371954;4758.809647614091;4786.377770889762;4829.492903245108;5101.20931255656;5111.412187598399;5114.33513643224;5120.769565369567;5163.819266325736;4953.2570114483115;4963.503649635008;4967.155583550805;4967.180415231446;5073.746312684351;4904.828331008469;4917.139500587383;4933.50664933511;4973.676711013773;5156.432792392834;4867.440244371872;4984.4267909190185;4993.50064993505;4996;5015.27278544609;5019.121653710586;5026.447090820006;5029.698218106925;5030.949690503048;5032.345795046621;3863.208042351311;3899.200663863901;3916.099297161669;3936.6653834423823;3979.6816254699556;3564.9643503565153;3581.8030008349792;3605.603383627799;3625.818709064536;3630.7821530708243;4687.343771871941;4729.929051064168;4740.2178640523925;4770.332153498513;4801.663883528119;4954.752262386938;5014.348134742533;5034.723090230073;5061.848144555669;5063.924041139312;4691.483936766953;4760.928586071212;4765.380500534978;4805.6155507559315;4877.146499362598;4361.171377438277;4485.215087359699;4515.2324104902245;4534.911621210952;4648.697834640738;5052.671576347526;5061.468545802712;5104.2343648453025;5136.486351364833;5150.948490515122;5027.195648696191;5072.1123803335;5078.365204349457;5104.132297509358;5162.174052151638;4975.427825799935;5119.769610367468;5128.000039992315;5188.325517682677;5208.322918020633;4895.975520122377;4950.282209079592;4980.726060066731;4995.200767877122;5012.649114561946;5021.6735912165595;5120.25756265332;5130.589552835839;5184.248283998874;5251.816186433456;4717.693349932243;4798.712077275374;4853.854384368475;4963.305137280856;5008.123578373843;4965.702057876539;4986.127427700066;4990.251462280687;4993.400791904995;5069.062223488666;4735.21868891629;4863.756812159449;4867.318575399376;4965.950340496694;4994.350734404504;4755.904881902274;4877.048975449753;4966.031623833318;4979.651424400257;5121.923171152361;4877.12211801879;4894.461609222912;4919.262110683426;4933.851984440473;4935.629827763004 12:28:12 INFO - 2015-11-12 12:28:12,925 DEBUG : BROWSER_OUTPUT: |1;ext.html;464.87913142582937;468.0194991492823;475.3321583175637;505.8128492457791;520.648562220501;33844;34738.478922816175;34858.119863219166;34865.47701784472;34945.65054349456;36798;37362.252754944886;37383;37418.625813741855;37425.81287093561;8247.257746802787;8360;8451.83096338073;8458.323334133254;8465.703700370488;8164.265216130547;8192.467489613186;8200.958995205016;8318.126596707349;8324.167583241688;8211.876821847676;8233.21784430481;8334.66661333549;8338.207870252316;8359.164083591653;8149.755507334789;8268.545230012347;8278.668853245863;8390.286825619829;8399.62201700925;7962.044554653478;8019.518828870228;8027.15714849944;8158.673653053871;8159.796005099861;34512.654873451196;34546.48180277298;34640.480392794125;34698.82650586756;35037.64962350369;2697.9055733049445;2712.1185614675114;2712.4168303814777;2743;2743.1084897408223;23933.162339318213;24359.269221923372;25413.618795718077;26015.21954341373;26372.208833735018;1999.990000050005;2097.737782777153;2109.6202683516963;2123.5434381607874;2201.0755482697305;248816;253624;257407;257524;259976;45624;46980.5301946983;55430.44569554253;57937.130943035045;59635.701821491486;53620.19569706458;53621.463785361644;53820.461795382325;54229;54425;14161.504347347793;14199.71600567983;14255.78616320756;14285;14347.497837575635;10645.308054976556;10665.146788256921;10722.839157412645;10743.78512429747;10751;17669;17725.822741772674;17761.46715598534;17835.910820446075;17931.462056138338;7397.8150546236775;7738.380929525737;7739.729109481141;7744.961275193588;7758.456908016497;839.2404873589411;874.9212570868652;898.6495266845935;923.9743884288434;975.5219942228257;24306.27081187567;24588.262352129466;24719.62920556193;24759.133430329854;24766;910.7632015675839;915.0986278515657;920.0385597051097;921.2814005076051;933.4819175357605;12338.259704417764;12566.748665026831;12575.622731318075;12743.745125097632;12784.105112642212;339299;348065;348252;349926;351483;47896;48062.51937480651;48117.66940975329;48148;48259.276110858365;1180.9527618895147;1185.4783895086134;1190.9404529773476;1193.7254431480808;1201.1351826684772;23759.52480950406;27233.455330893667;27331;28306;28493.145205643865;43698.781506092266;43904;44441.777791110835;44529.332060018474;44551.55448445474;251276;254645;254802;254936;256974;35947.82026089853;36899.446508302935;37360.626393735714;37907.62092379151;37940.395662412026;35970.28059438849;37594;37902.24195516129;38377.61622383852;38569.228615428096;31287.84356078205;31503;31591;31736.523952141197;32253.677463225067;31674.841625791723;34353.31293374168;35304.29391412106;35543.64456355404;35821.64178358183;35107.29785404329;35113.122171945906;35604.64395356013;36075.81962090278;36149.457758133125;26236.344091397867;27509.17472475829;28298.71701282961;28407.573886391307;28632.856835715687;21434.89282553577;21815.018324175133;21818.781812181674;21884.12463501442;21912.342629721134 12:28:12 INFO - 2015-11-12 12:28:12,925 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.2256021542911;293.05635852554764;299.2623183851805;299.81561339776033;304.1377694236839;12933.224006559612;13420.194788312709;15135.697286054272;15222.467213647511;15769.605759855995;15608.375664973388;15760;16251.349946002145;16263.593410164753;16510.917445412786;4539.909201815962;4914.287428322891;4924.482929292427;4926.630502712311;4965.131102057126;4152;4227.260229459832;4296.0548679290505;4297.97851010746;4723.858284251478;4196.433481480007;4230.19626271009;4255.17024180285;4284.164587905359;4285.785710714467;3995.9001024974464;4109.547949725527;4182.7490350578755;4194.853180138696;4263.424437700917;3494.091536200581;3511.473279008144;3538.9115272118147;3563.322968635977;3565.964340356615;11370.260933039408;11534;11545.365004924726;11643.35961522116;11733.120015998835;1584.8335924727853;1588.6743217640355;1604.7592861070816;1606.2611198848545;1623.7564365345174;8349.206825351583;8372.83254334916;8399.790005249857;8406.159384061606;8625.051244363114;1331.567240646784;1352.891768658505;1354.613935028522;1403.1510935883848;1406.9577912662637;48725.51274487245;50346;50654.49345506535;51232.74383628058;52097.73951130258;5651.604387692904;5735.569832262597;5794.101914203306;5802.854928626818;5861.062230043258;6620.569662971891;6639.966800165968;6643.302453242437;6645.966770166118;6658.933410665928;4822.590079843182;4847.2729090636685;4848.612111031109;4854.80580776765;4896.192128298862;5163.561097306696;5182.689038657692;5185.714785686823;5197.8440646780655;5229.346331708536;2564.1538292363475;2576.188500622298;2597.6103584462103;2602.2323414592743;2610.7128215896237;891.362675686874;915.4324318922311;935.4948327902993;963.4460185393286;987.3779518903045;359.80031082748803;387.5968992248087;390.0424457955712;400.18562225870215;415.23803819990053;9856.408615483095;9964.800703986024;10020.549075291628;10045.849312260321;10095.141912937483;391.36207980990804;396.04742692629065;397.0292634508599;404.1351507773367;424.9915001700011;5536.7785288588;5593.944060559343;5639.774409023593;5649.180868774005;5657.8019769307875;449235;454400;456717;457434;460038;61539.92300384963;61748;62666.373336266966;62891.99999999908;64051.35948640454;443.9822407103744;448.6007453366506;449.3843434494763;449.4202478802308;450.4234579737941;9412.435253884789;9481.194098501705;9546.093121153479;9590.136887680143;9628.566714497725;28855.422891542472;30365.848170759004;30521.389572207987;30736.231594210323;30995.535066974466;41636.375454367604;41680.1663966725;41977.580224197365;42520.78739606282;42941.355879661205;5464.371597266365;5467.39858615544;5516.531094856982;5568.582356323373;5581.330240371181;9875.851862221929;10309.587616495257;10350.120239779402;10452.895471045496;10537.789244215226;7480.476366654282;7621.466497345133;8356.707515236938;8827.293816494537;8958.462492250486;7594.278543538355;7982.401319900914;8023.157568455462;8271.875921861298;8318.958405207935;8563.95718021431;8585.484870907765;8663.740087797376;8761.956190219009;8786.648534058566;12309;12502.187357821713;13129.540466083641;13217.867821321664;13352.198868067948;12911.483540658268;13398.196108233537;13416.865831341562;13542.458301667823;13787.724245515234 12:28:12 INFO - 2015-11-12 12:28:12,929 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1463.15868375684;1550.914699691517;1562.4297131546982;1568.7333153363927;1594.163064391195;6017.879642407149;6407.743690252384;6548.148740663713;6920.238773734898;7067.85864282714;6504.121943537621;6769.864602707943;6771.4921380896385;6790.796276111712;6894.724211031566;1850.3893715073993;1877.3053970031108;1892.8201820827069;1908.2080936411373;1915.3200613782117;1920.0879582198484;1933.0334832583708;1936.5061909213132;1964.1750464804816;1979.21820880752;1895.9431217063511;1919.5585015446457;1926.364299781076;1944.1445763863926;1952.0044777163678;1870.326682394337;1892.5174080609424;1895.8862468251812;1904.6381187574316;1919.4529559075597;1847.4919397165752;1858.7490688757116;1868.0846385271254;1877.6995680691161;1913.7416448779377;6777.728890844361;6782.355676210752;6789.762358317435;6804.11546498952;6847.931520684829;4046.8381264749373;4122.237386083584;4130.0500884796365;4143.254214241435;4173.6661067114865;2188.9452763680874;2214.2914267434426;2324.721033475994;2354.3054798834387;2380.73811880693;744.1219361153836;771.7877583664481;793.1552896165623;803.8311954489506;830.8753686946945;9067.54662266884;9103.499307538083;9111.589978450986;9137.725868223964;9160.31297652672;3527.488514165483;3569.94645080324;3653.0684675408133;3721.6092310307567;3742.6070262622034;7760.379169666413;7766.417518686008;7784.883226751604;7810.336121429742;7924.326432253323;4100.5899410058755;4121.711480196357;4158.064435501988;4160.355144952538;4201.264778663722;3753.0804952786743;3756.229972855558;3772.9245415091546;3781.2248489059675;3825.081980324702;3228.1445416964525;3241.4651582489096;3243.2864769750618;3289.0626171540994;3293.341331733615;1061.686802393296;1061.8991195836384;1062.4050531702271;1067.40758878823;1080.098118071419;1166.049669519339;1174.48322737995;1175.5474142455216;1196.6469891382062;1200.591798788416;6320.810375688737;6367.936320636827;6453.580517266362;6465.870682586416;6469;1010.075780660702;1014.4268488304084;1028.285341687535;1028.408665017603;1037.4397825174472;5106.591472682251;5152.201408781645;5176.50823171798;5194.11700010999;5227.738613069331;7378.483506154625;7593.354564862048;7890;7936.365090792723;8368.20502052304;8088.797780055545;8101.311388531923;8123.7156699515235;8127.959360203161;8252.381071419668;6292.653904035231;6327.651979141099;6492.577982431127;6526.021096835512;6590.406863382319;6372.55392122547;6427.068075129174;6438.195225596801;6496.70764815575;6509.544331896911;7075.929240707527;7203.459740519377;7206.639668016683;7280.490365674564;7333.413326933939;7296.124465064227;7400.481966262525;7462.216467271075;7478.551286922802;7592.354649854824;5813.215215945962;5878.059510478303;5886.558508111823;5946.672932988728;5955.880882382415;6634.137562116894;6641.634710090798;6716.865662686621;6724.327567243432;6767.830804229934;6293.118963345227;6293.213348331458;6340.207474065742;6342.682865856781;6352.872942541216;6091.147239386578;6137.048757442603;6180.196574445294;6253.718582663882;6291.685415729286;6249.593776404519;6269.655168965751;6283.37166283368;6290.779822706183;6375;5599.776008959759;5663.1788390682295;5704.172894930295;5742.712864356849;5757.309122905278;5694.943050569441;5744.372910116252;5782.624129431573;5810.273715785527;5811.389804070512 12:28:12 INFO - 2015-11-12 12:28:12,930 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.7399470503022;274.68960075115115;278.55709422018975;280.90870467098193;280.98595070246506;5333.546648534879;5388.084025715628;5419.430959749224;5493.478119578644;5539.667619942807;5306.840794776153;5330.3603567571945;5372.57019438445;5386.596005299599;5418.593605479585;4166.729162604436;4170.1242739024765;4213.683973701969;4238.152369526092;4244.236037513262;4200.201961627296;4207.095474472988;4213.073123912734;4222.239996800575;4233.851815186469;4043.5147782266167;4153.667706583481;4155.6883233757435;4159.376093585971;4204.600562946515;4170.937435938464;4176.958230417687;4200.936985945214;4229.894252643693;4232.746035237865;3613.8554457821656;3640.690541303992;3677.42999835026;3680.2639472105684;3688.5573731152167;5243.318368612094;5274.340707411574;5289.814856480005;5314.362276526803;5342.652727572696;4482.8431004915;4523.47979982303;4592.908141837178;4593.678442509025;4596.701214421052;5603.971980140073;5658.490735833795;5661.490465858093;5664;5741.827745167651;3748.662620364153;3771.208046310278;3786.734928555002;3789.5452545694416;3797.715171362159;5730.656160630376;5779.9422005779825;5865.736041878125;5874.148248503986;5933.792317268918;3752.043228976648;3770.472133901256;3783.2622638585212;3808.4668146459517;3835.137094153793;3834;3843.7885916274313;3859.4789703390243;3902.70729695274;3909.706771992055;4489.214387482243;4498.932516012263;4504.752238626907;4554.749488778083;4582.991741816795;5548.167774833807;5660.235868157828;5698.1452782083015;5746.224259724883;5773.39379365169;1384.2940100548592;1408.5985494134122;1410.9223992680502;1422.7510185717665;1424.095699230975;894.1505569708803;899.7975455522586;909.9317551183556;910.9407888487227;921.8893732752113;5403.540699040625;5428.5928555358505;5487.780488780404;5495.642783219078;5522.337319521603;5936.910946335808;5971.373005834412;5985.191999080155;6004.699765011732;6049.667268300285;5409.702466364309;5426.348838139448;5485.780568777284;5504.174373843955;5518.172274158908;3186.3149422874194;3300.471924492118;3311.6853898879567;3313.2213929726495;3317.369699757087;6030.517558595302;6054.636721796706;6061.454469097803;6074.9392506075255;6117.143599896018;5859.589828711949;5956.136360227742;6059.8485037873525;6066.029435290332;6111.57218994675;6039.66781826995;6047.9395206047375;6068.575199735976;6070.605410648293;6079.0273556230795;5951.22634057587;5954.672493012926;5960.105984102419;5962.2249107615735;5966.164736936746;5701.743421545957;5767.567432442667;5792.420757924174;5793.623414478046;5853.268341457318;6023.45788879003;6030.969845150747;6042.8791424170395;6048.758049677964;6101.572889897665;3733.234686889127;3778.471014057979;3785.2966165226308;3786.5266841644793;3790.166163444038;5771.769129234952;5924.4667979882015;5930.555208359304;5935.643861368331;5944.048952167633;5791.53667706574;5801.3038435388025;5891.293044834647;5895.911561326498;5914.319853216935;5817.272840894888;5868.735906884115;5884.705764711833;5891.823245302648;5894.528437724886;5704.885902281848;5719.542436605145;5735.283089613798;5739.5695322850115;5743.3395159557185;5694.601377903673;5854.0340843760305;5856.267966504187;5869.73586188614;5874.17761513397;5757.453041961007;5766.163906233656;5768.163616275533;5783.884322313615;5816.76732930678 12:28:12 INFO - 2015-11-12 12:28:12,934 DEBUG : BROWSER_OUTPUT: |5;yui.html;647.8186107889793;651.5764752910608;661.6592454885733;685.2051620120661;696.2689176364817;12024.33866137362;12429.31638759868;12470.37648117595;12470.750584988295;12472.625821225354;11421.600243991463;12300.753984920297;12502.499900004012;12666;12677.936610316936;594.4174708785393;603.8067818298147;755.5164694595463;758.6510205305566;771.240328276647;756.0549313358302;756.8486302739474;758.6434375843345;759.350755104386;770.4144849914078;744.7653988993477;776.9300762931335;792.1800936031209;801.2788490358665;803.0203152154362;739.6671497826;783.5572901310769;786.6813940354166;791.6595863778573;791.7387262203459;568.3691102875805;571.2545128607165;574.2936188488142;574.7499837570671;574.9798757043484;11919.702007449796;12059.577914773028;12068.215565988183;12072.456739446747;12304.630861074182;8308.29379502737;8332.7083552076;8432.40973131881;8733.868991965062;8825.867611985825;7648;8187.140350263256;8207.876881846778;8259.752207433787;8473.830523389497;2662.5739881619043;2666.3067602423316;2719.3473566344132;2771.2794673384865;2773.1126039667315;41188.58811411878;42126.36810447846;42172.78913605443;42478.57521424777;42612.3608145878;5764.337101233328;6018.849528761816;6033.245844269466;6126.356732543108;6356.173697419398;10241.94879025615;10325.535350909227;10330.431826249478;10375.325603835727;10456.477176141163;5507.366652834895;5510;5513.145462453326;5582.134769110794;5697.202391665171;3253.3330667213163;3325.1687078230443;3339.93320133596;3398.4222682144095;3581.301646179022;2329.0101706774553;2359.7876191142877;2361.2089949866986;2388.4028992751814;2404.0624156578947;346.34540718042916;348.9511468394427;349.8023616656581;356.9375359312162;364.58437381385244;456.7738969210262;479.549223729693;492.5271739130403;511.872031992002;545.0080852847778;6748.561343512656;7229.457790665721;7294.416446684252;7305.744298949511;7339.339459448568;428.14584903118475;521.5045706578766;525.9710715910662;547.635822178255;551.9595562364971;3325.451300535433;3368.4105281575626;3391.7117045051446;3495.2310491691787;3515.1739341254784;52836;52846.73576632169;53018.20472692913;53032.204516932274;53525.732371337894;44655.776721116184;45260;45273.773631132295;45448;45556;38650;38665.42001869974;39105.80447097803;40853.38719919204;41346.1730765389;7046.2249152594195;7292.817679558054;7310.59791711461;7335.669894854637;7522.623868806429;29924;30043.513842592227;30246.84876575603;30438.391232175676;30789.846050769604;37226.255474890895;37260.627393725714;37873.81063094667;40835.38746918858;40842.59157408507;6569.9014514783275;6653.434458071119;6715.664216789043;6815.079964204769;6878.828029299308;9469.621215151317;9488.573014214515;9661.951690241503;9892.901070989197;10365.118964887768;9163.541822908961;9324.228634245748;9361.85957210656;9478.763030924281;9526.380785248937;8977.10228977097;9054.411463254868;9278.72163835086;9402.247820174507;9484.336096473457;8584.313254939465;8676.089010654043;8822.5588720565;9228.169464748205;9263.397879137834;7738.883916741366;7745.728899488491;7802.726904558313;8145.81885626569;8178.100408955129;7168.53404528704;7452.180260171268;7929.365650747811;8035.156308587748;8223.383246256435 12:28:12 INFO - 2015-11-12 12:28:12,934 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:28:12 INFO - 2015-11-12 12:28:12,934 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:28:12 INFO - 2015-11-12 12:28:12,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 12:28:12 INFO - 2015-11-12 12:28:12,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: __startTimestamp1447360092919__endTimestamp 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4700.42 Median:4853.85 stddev:494.17 (10.2%) stddev-sans-first:470.66 12:28:12 INFO - 2015-11-12 12:28:12,935 DEBUG : BROWSER_OUTPUT: Values: 2721.1 2728.3 2749.3 2795.8 2804.0 4467.7 4592.3 4612.4 4684.1 4807.5 4643.2 4667.7 4672.2 4713.0 4735.0 4318.0 4357.9 4453.3 4528.7 4537.0 4389.0 4398.7 4413.5 4413.7 4421.2 4440.1 4443.8 4445.6 4447.8 4480.1 4245.4 4278.2 4339.5 4404.2 4441.9 4432.4 4444.5 4460.6 4462.1 4529.2 4416.9 4589.7 4631.9 4668.2 4703.5 4666.1 4781.1 4787.9 4810.7 5034.8 4993.7 5121.8 5129.1 5143.9 5152.3 4577.2 4594.3 4758.8 4786.4 4829.5 5101.2 5111.4 5114.3 5120.8 5163.8 4953.3 4963.5 4967.2 4967.2 5073.7 4904.8 4917.1 4933.5 4973.7 5156.4 4867.4 4984.4 4993.5 4996.0 5015.3 5019.1 5026.4 5029.7 5030.9 5032.3 3863.2 3899.2 3916.1 3936.7 3979.7 3565.0 3581.8 3605.6 3625.8 3630.8 4687.3 4729.9 4740.2 4770.3 4801.7 4954.8 5014.3 5034.7 5061.8 5063.9 4691.5 4760.9 4765.4 4805.6 4877.1 4361.2 4485.2 4515.2 4534.9 4648.7 5052.7 5061.5 5104.2 5136.5 5150.9 5027.2 5072.1 5078.4 5104.1 5162.2 4975.4 5119.8 5128.0 5188.3 5208.3 4896.0 4950.3 4980.7 4995.2 5012.6 5021.7 5120.3 5130.6 5184.2 5251.8 4717.7 4798.7 4853.9 4963.3 5008.1 4965.7 4986.1 4990.3 4993.4 5069.1 4735.2 4863.8 4867.3 4966.0 4994.4 4755.9 4877.0 4966.0 4979.7 5121.9 4877.1 4894.5 4919.3 4933.9 4935.6 12:28:12 INFO - 2015-11-12 12:28:12,936 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,936 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43867.29 Median:35072.47 stddev:75862.49 (216.3%) stddev-sans-first:76005.31 12:28:12 INFO - 2015-11-12 12:28:12,937 DEBUG : BROWSER_OUTPUT: Values: 464.9 468.0 475.3 505.8 520.6 33844.0 34738.5 34858.1 34865.5 34945.7 36798.0 37362.3 37383.0 37418.6 37425.8 8247.3 8360.0 8451.8 8458.3 8465.7 8164.3 8192.5 8201.0 8318.1 8324.2 8211.9 8233.2 8334.7 8338.2 8359.2 8149.8 8268.5 8278.7 8390.3 8399.6 7962.0 8019.5 8027.2 8158.7 8159.8 34512.7 34546.5 34640.5 34698.8 35037.6 2697.9 2712.1 2712.4 2743.0 2743.1 23933.2 24359.3 25413.6 26015.2 26372.2 2000.0 2097.7 2109.6 2123.5 2201.1 248816.0 253624.0 257407.0 257524.0 259976.0 45624.0 46980.5 55430.4 57937.1 59635.7 53620.2 53621.5 53820.5 54229.0 54425.0 14161.5 14199.7 14255.8 14285.0 14347.5 10645.3 10665.1 10722.8 10743.8 10751.0 17669.0 17725.8 17761.5 17835.9 17931.5 7397.8 7738.4 7739.7 7745.0 7758.5 839.2 874.9 898.6 924.0 975.5 24306.3 24588.3 24719.6 24759.1 24766.0 910.8 915.1 920.0 921.3 933.5 12338.3 12566.7 12575.6 12743.7 12784.1 339299.0 348065.0 348252.0 349926.0 351483.0 47896.0 48062.5 48117.7 48148.0 48259.3 1181.0 1185.5 1190.9 1193.7 1201.1 23759.5 27233.5 27331.0 28306.0 28493.1 43698.8 43904.0 44441.8 44529.3 44551.6 251276.0 254645.0 254802.0 254936.0 256974.0 35947.8 36899.4 37360.6 37907.6 37940.4 35970.3 37594.0 37902.2 38377.6 38569.2 31287.8 31503.0 31591.0 31736.5 32253.7 31674.8 34353.3 35304.3 35543.6 35821.6 35107.3 35113.1 35604.6 36075.8 36149.5 26236.3 27509.2 28298.7 28407.6 28632.9 21434.9 21815.0 21818.8 21884.1 21912.3 12:28:12 INFO - 2015-11-12 12:28:12,937 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,937 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23212.17 Median:2370.98 stddev:74584.56 (3145.7%) stddev-sans-first:74773.93 12:28:12 INFO - 2015-11-12 12:28:12,939 DEBUG : BROWSER_OUTPUT: Values: 292.2 293.1 299.3 299.8 304.1 12933.2 13420.2 15135.7 15222.5 15769.6 15608.4 15760.0 16251.3 16263.6 16510.9 4539.9 4914.3 4924.5 4926.6 4965.1 4152.0 4227.3 4296.1 4298.0 4723.9 4196.4 4230.2 4255.2 4284.2 4285.8 3995.9 4109.5 4182.7 4194.9 4263.4 3494.1 3511.5 3538.9 3563.3 3566.0 11370.3 11534.0 11545.4 11643.4 11733.1 1584.8 1588.7 1604.8 1606.3 1623.8 8349.2 8372.8 8399.8 8406.2 8625.1 1331.6 1352.9 1354.6 1403.2 1407.0 48725.5 50346.0 50654.5 51232.7 52097.7 5651.6 5735.6 5794.1 5802.9 5861.1 6620.6 6640.0 6643.3 6646.0 6658.9 4822.6 4847.3 4848.6 4854.8 4896.2 5163.6 5182.7 5185.7 5197.8 5229.3 2564.2 2576.2 2597.6 2602.2 2610.7 891.4 915.4 935.5 963.4 987.4 359.8 387.6 390.0 400.2 415.2 9856.4 9964.8 10020.5 10045.8 10095.1 391.4 396.0 397.0 404.1 425.0 5536.8 5593.9 5639.8 5649.2 5657.8 449235.0 454400.0 456717.0 457434.0 460038.0 61539.9 61748.0 62666.4 62892.0 64051.4 444.0 448.6 449.4 449.4 450.4 9412.4 9481.2 9546.1 9590.1 9628.6 28855.4 30365.8 30521.4 30736.2 30995.5 41636.4 41680.2 41977.6 42520.8 42941.4 5464.4 5467.4 5516.5 5568.6 5581.3 9875.9 10309.6 10350.1 10452.9 10537.8 7480.5 7621.5 8356.7 8827.3 8958.5 7594.3 7982.4 8023.2 8271.9 8319.0 8564.0 8585.5 8663.7 8762.0 8786.6 12309.0 12502.2 13129.5 13217.9 13352.2 12911.5 13398.2 13416.9 13542.5 13787.7 12:28:12 INFO - 2015-11-12 12:28:12,939 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,939 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4762.07 Median:5845.64 stddev:2451.43 (41.9%) stddev-sans-first:2445.77 12:28:12 INFO - 2015-11-12 12:28:12,940 DEBUG : BROWSER_OUTPUT: Values: 1463.2 1550.9 1562.4 1568.7 1594.2 6017.9 6407.7 6548.1 6920.2 7067.9 6504.1 6769.9 6771.5 6790.8 6894.7 1850.4 1877.3 1892.8 1908.2 1915.3 1920.1 1933.0 1936.5 1964.2 1979.2 1895.9 1919.6 1926.4 1944.1 1952.0 1870.3 1892.5 1895.9 1904.6 1919.5 1847.5 1858.7 1868.1 1877.7 1913.7 6777.7 6782.4 6789.8 6804.1 6847.9 4046.8 4122.2 4130.1 4143.3 4173.7 2188.9 2214.3 2324.7 2354.3 2380.7 744.1 771.8 793.2 803.8 830.9 9067.5 9103.5 9111.6 9137.7 9160.3 3527.5 3569.9 3653.1 3721.6 3742.6 7760.4 7766.4 7784.9 7810.3 7924.3 4100.6 4121.7 4158.1 4160.4 4201.3 3753.1 3756.2 3772.9 3781.2 3825.1 3228.1 3241.5 3243.3 3289.1 3293.3 1061.7 1061.9 1062.4 1067.4 1080.1 1166.0 1174.5 1175.5 1196.6 1200.6 6320.8 6367.9 6453.6 6465.9 6469.0 1010.1 1014.4 1028.3 1028.4 1037.4 5106.6 5152.2 5176.5 5194.1 5227.7 7378.5 7593.4 7890.0 7936.4 8368.2 8088.8 8101.3 8123.7 8128.0 8252.4 6292.7 6327.7 6492.6 6526.0 6590.4 6372.6 6427.1 6438.2 6496.7 6509.5 7075.9 7203.5 7206.6 7280.5 7333.4 7296.1 7400.5 7462.2 7478.6 7592.4 5813.2 5878.1 5886.6 5946.7 5955.9 6634.1 6641.6 6716.9 6724.3 6767.8 6293.1 6293.2 6340.2 6342.7 6352.9 6091.1 6137.0 6180.2 6253.7 6291.7 6249.6 6269.7 6283.4 6290.8 6375.0 5599.8 5663.2 5704.2 5742.7 5757.3 5694.9 5744.4 5782.6 5810.3 5811.4 12:28:12 INFO - 2015-11-12 12:28:12,940 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,941 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4769.69 Median:5499.91 stddev:1467.42 (26.7%) stddev-sans-first:1432.21 12:28:12 INFO - 2015-11-12 12:28:12,942 DEBUG : BROWSER_OUTPUT: Values: 273.7 274.7 278.6 280.9 281.0 5333.5 5388.1 5419.4 5493.5 5539.7 5306.8 5330.4 5372.6 5386.6 5418.6 4166.7 4170.1 4213.7 4238.2 4244.2 4200.2 4207.1 4213.1 4222.2 4233.9 4043.5 4153.7 4155.7 4159.4 4204.6 4170.9 4177.0 4200.9 4229.9 4232.7 3613.9 3640.7 3677.4 3680.3 3688.6 5243.3 5274.3 5289.8 5314.4 5342.7 4482.8 4523.5 4592.9 4593.7 4596.7 5604.0 5658.5 5661.5 5664.0 5741.8 3748.7 3771.2 3786.7 3789.5 3797.7 5730.7 5779.9 5865.7 5874.1 5933.8 3752.0 3770.5 3783.3 3808.5 3835.1 3834.0 3843.8 3859.5 3902.7 3909.7 4489.2 4498.9 4504.8 4554.7 4583.0 5548.2 5660.2 5698.1 5746.2 5773.4 1384.3 1408.6 1410.9 1422.8 1424.1 894.2 899.8 909.9 910.9 921.9 5403.5 5428.6 5487.8 5495.6 5522.3 5936.9 5971.4 5985.2 6004.7 6049.7 5409.7 5426.3 5485.8 5504.2 5518.2 3186.3 3300.5 3311.7 3313.2 3317.4 6030.5 6054.6 6061.5 6074.9 6117.1 5859.6 5956.1 6059.8 6066.0 6111.6 6039.7 6047.9 6068.6 6070.6 6079.0 5951.2 5954.7 5960.1 5962.2 5966.2 5701.7 5767.6 5792.4 5793.6 5853.3 6023.5 6031.0 6042.9 6048.8 6101.6 3733.2 3778.5 3785.3 3786.5 3790.2 5771.8 5924.5 5930.6 5935.6 5944.0 5791.5 5801.3 5891.3 5895.9 5914.3 5817.3 5868.7 5884.7 5891.8 5894.5 5704.9 5719.5 5735.3 5739.6 5743.3 5694.6 5854.0 5856.3 5869.7 5874.2 5757.5 5766.2 5768.2 5783.9 5816.8 12:28:12 INFO - 2015-11-12 12:28:12,942 DEBUG : BROWSER_OUTPUT: 12:28:12 INFO - 2015-11-12 12:28:12,942 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11565.47 Median:3132.79 stddev:14233.03 (454.3%) stddev-sans-first:14249.34 12:28:12 INFO - 2015-11-12 12:28:12,943 DEBUG : BROWSER_OUTPUT: Values: 647.8 651.6 661.7 685.2 696.3 12024.3 12429.3 12470.4 12470.8 12472.6 11421.6 12300.8 12502.5 12666.0 12677.9 594.4 603.8 755.5 758.7 771.2 756.1 756.8 758.6 759.4 770.4 744.8 776.9 792.2 801.3 803.0 739.7 783.6 786.7 791.7 791.7 568.4 571.3 574.3 574.7 575.0 11919.7 12059.6 12068.2 12072.5 12304.6 8308.3 8332.7 8432.4 8733.9 8825.9 7648.0 8187.1 8207.9 8259.8 8473.8 2662.6 2666.3 2719.3 2771.3 2773.1 41188.6 42126.4 42172.8 42478.6 42612.4 5764.3 6018.8 6033.2 6126.4 6356.2 10241.9 10325.5 10330.4 10375.3 10456.5 5507.4 5510.0 5513.1 5582.1 5697.2 3253.3 3325.2 3339.9 3398.4 3581.3 2329.0 2359.8 2361.2 2388.4 2404.1 346.3 349.0 349.8 356.9 364.6 456.8 479.5 492.5 511.9 545.0 6748.6 7229.5 7294.4 7305.7 7339.3 428.1 521.5 526.0 547.6 552.0 3325.5 3368.4 3391.7 3495.2 3515.2 52836.0 52846.7 53018.2 53032.2 53525.7 44655.8 45260.0 45273.8 45448.0 45556.0 38650.0 38665.4 39105.8 40853.4 41346.2 7046.2 7292.8 7310.6 7335.7 7522.6 29924.0 30043.5 30246.8 30438.4 30789.8 37226.3 37260.6 37873.8 40835.4 40842.6 6569.9 6653.4 6715.7 6815.1 6878.8 9469.6 9488.6 9662.0 9892.9 10365.1 9163.5 9324.2 9361.9 9478.8 9526.4 8977.1 9054.4 9278.7 9402.2 9484.3 8584.3 8676.1 8822.6 9228.2 9263.4 7738.9 7745.7 7802.7 8145.8 8178.1 7168.5 7452.2 7929.4 8035.2 8223.4 12:28:12 INFO - 2015-11-12 12:28:12,944 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:28:12 INFO - 2015-11-12 12:28:12,944 DEBUG : BROWSER_OUTPUT: 12:28:13 INFO - 2015-11-12 12:28:13,629 INFO : Browser exited with error code: 0 12:28:13 INFO - 2015-11-12 12:28:13,660 INFO : Completed test dromaeo_css (00:18:34) 12:28:13 INFO - 2015-11-12 12:28:13,660 INFO : Starting test kraken 12:28:13 INFO - 2015-11-12 12:28:13,660 DEBUG : operating with platform_type : mac_ 12:28:13 INFO - 2015-11-12 12:28:13,660 INFO : Initialising browser for kraken test... 12:28:13 INFO - 2015-11-12 12:28:13,674 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp7gzkNe/profile http://localhost:49265/getInfo.html 12:28:17 INFO - 2015-11-12 12:28:17,269 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:28:17 INFO - 2015-11-12 12:28:17,269 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:28:17 INFO - 2015-11-12 12:28:17,269 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:28:17 INFO - 2015-11-12 12:28:17,269 DEBUG : BROWSER_OUTPUT: __metrics 12:28:17 INFO - 2015-11-12 12:28:17,983 INFO : Browser initialized. 12:28:17 INFO - 2015-11-12 12:28:17,984 INFO : Running cycle 1/1 for kraken test... 12:28:17 INFO - 2015-11-12 12:28:17,984 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp7gzkNe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:28:30 INFO - 2015-11-12 12:28:30,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 241049600 12:28:30 INFO - 2015-11-12 12:28:30,288 DEBUG : BROWSER_OUTPUT: 12:28:32 INFO - 2015-11-12 12:28:32,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:33 INFO - 2015-11-12 12:28:33,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 258686976 12:28:33 INFO - 2015-11-12 12:28:33,564 DEBUG : BROWSER_OUTPUT: 12:28:36 INFO - 2015-11-12 12:28:36,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 12:28:37 INFO - 2015-11-12 12:28:37,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 266653696 12:28:37 INFO - 2015-11-12 12:28:37,163 DEBUG : BROWSER_OUTPUT: 12:28:40 INFO - 2015-11-12 12:28:40,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 12:28:40 INFO - 2015-11-12 12:28:40,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 266723328 12:28:40 INFO - 2015-11-12 12:28:40,940 DEBUG : BROWSER_OUTPUT: 12:28:43 INFO - 2015-11-12 12:28:43,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 12:28:43 INFO - 2015-11-12 12:28:43,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 267079680 12:28:43 INFO - 2015-11-12 12:28:43,702 DEBUG : BROWSER_OUTPUT: 12:28:46 INFO - 2015-11-12 12:28:46,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:46 INFO - 2015-11-12 12:28:46,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 267436032 12:28:46 INFO - 2015-11-12 12:28:46,584 DEBUG : BROWSER_OUTPUT: 12:28:49 INFO - 2015-11-12 12:28:49,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:50 INFO - 2015-11-12 12:28:50,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 266870784 12:28:50 INFO - 2015-11-12 12:28:50,582 DEBUG : BROWSER_OUTPUT: 12:28:54 INFO - 2015-11-12 12:28:54,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 12:28:54 INFO - 2015-11-12 12:28:54,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 266084352 12:28:54 INFO - 2015-11-12 12:28:54,658 DEBUG : BROWSER_OUTPUT: 12:28:57 INFO - 2015-11-12 12:28:57,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 12:28:58 INFO - 2015-11-12 12:28:58,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 265994240 12:28:58 INFO - 2015-11-12 12:28:58,469 DEBUG : BROWSER_OUTPUT: 12:29:00 INFO - 2015-11-12 12:29:00,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:00 INFO - 2015-11-12 12:29:00,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 267325440 12:29:00 INFO - 2015-11-12 12:29:00,743 DEBUG : BROWSER_OUTPUT: 12:29:02 INFO - 2015-11-12 12:29:02,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:03 INFO - 2015-11-12 12:29:03,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 267239424 12:29:03 INFO - 2015-11-12 12:29:03,321 DEBUG : BROWSER_OUTPUT: 12:29:05 INFO - 2015-11-12 12:29:05,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:06 INFO - 2015-11-12 12:29:06,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 267935744 12:29:06 INFO - 2015-11-12 12:29:06,192 DEBUG : BROWSER_OUTPUT: 12:29:09 INFO - 2015-11-12 12:29:09,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:09 INFO - 2015-11-12 12:29:09,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 267685888 12:29:09 INFO - 2015-11-12 12:29:09,671 DEBUG : BROWSER_OUTPUT: 12:29:12 INFO - 2015-11-12 12:29:12,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:13 INFO - 2015-11-12 12:29:13,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 266940416 12:29:13 INFO - 2015-11-12 12:29:13,165 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 268595200 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;119;115;117;129;127;127;128;128 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;192;165;176;186;157;178;180;150;189;158 12:29:15 INFO - 2015-11-12 12:29:15,282 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;193;208;201;192;192;193;193;198;195 12:29:15 INFO - 2015-11-12 12:29:15,283 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;84;94;132;81;82;85;86;137;79 12:29:15 INFO - 2015-11-12 12:29:15,283 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;104;145;105;106;104;143;104;104;147 12:29:15 INFO - 2015-11-12 12:29:15,283 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;135;149;145;138;143;149;140;143;136 12:29:15 INFO - 2015-11-12 12:29:15,283 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;156;153;148;149;150;149;150;149 12:29:15 INFO - 2015-11-12 12:29:15,283 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;128;127;125;127;127;122;122;130;128 12:29:15 INFO - 2015-11-12 12:29:15,284 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;71;73;74;75;76;80;73;73 12:29:15 INFO - 2015-11-12 12:29:15,284 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;78;78;81;80;80;81;80;81;82 12:29:15 INFO - 2015-11-12 12:29:15,284 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;102;103;101;110;108;108;100;103;103 12:29:15 INFO - 2015-11-12 12:29:15,284 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;145;153;164;155;153;155;153;153;163;160 12:29:15 INFO - 2015-11-12 12:29:15,284 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;184;185;173;185;175;176;186;185;184 12:29:15 INFO - 2015-11-12 12:29:15,285 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;82;80;85;85;84;89;89;90;89 12:29:15 INFO - 2015-11-12 12:29:15,285 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:29:15 INFO - 2015-11-12 12:29:15,285 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:29:15 INFO - 2015-11-12 12:29:15,285 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,728 12:29:15 INFO - 2015-11-12 12:29:15,285 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1447360155279__endTimestamp 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,286 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.40 Median:127.00 stddev:7.32 (5.8%) stddev-sans-first:7.50 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 119.0 115.0 117.0 129.0 127.0 127.0 128.0 128.0 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:173.10 Median:179.00 stddev:14.69 (8.2%) stddev-sans-first:13.90 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: Values: 192.0 165.0 176.0 186.0 157.0 178.0 180.0 150.0 189.0 158.0 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:195.10 Median:194.00 stddev:6.01 (3.1%) stddev-sans-first:5.40 12:29:15 INFO - 2015-11-12 12:29:15,287 DEBUG : BROWSER_OUTPUT: Values: 186.0 193.0 208.0 201.0 192.0 192.0 193.0 193.0 198.0 195.0 12:29:15 INFO - 2015-11-12 12:29:15,288 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,289 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.90 Median:83.00 stddev:21.86 (26.3%) stddev-sans-first:22.51 12:29:15 INFO - 2015-11-12 12:29:15,290 DEBUG : BROWSER_OUTPUT: Values: 79.0 84.0 94.0 132.0 81.0 82.0 85.0 86.0 137.0 79.0 12:29:15 INFO - 2015-11-12 12:29:15,290 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,290 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.00 Median:124.50 stddev:20.14 (16.2%) stddev-sans-first:20.29 12:29:15 INFO - 2015-11-12 12:29:15,290 DEBUG : BROWSER_OUTPUT: Values: 98.0 104.0 145.0 105.0 106.0 104.0 143.0 104.0 104.0 147.0 12:29:15 INFO - 2015-11-12 12:29:15,290 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:141.40 Median:143.00 stddev:5.23 (3.7%) stddev-sans-first:5.17 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 149.0 145.0 138.0 143.0 149.0 140.0 143.0 136.0 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.50 stddev:2.44 (1.6%) stddev-sans-first:2.55 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 156.0 153.0 148.0 149.0 150.0 149.0 150.0 149.0 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.80 Median:127.00 stddev:2.90 (2.3%) stddev-sans-first:2.73 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: Values: 122.0 128.0 127.0 125.0 127.0 127.0 122.0 122.0 130.0 128.0 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.50 stddev:3.60 (4.9%) stddev-sans-first:3.32 12:29:15 INFO - 2015-11-12 12:29:15,291 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 71.0 73.0 74.0 75.0 76.0 80.0 73.0 73.0 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:80.50 stddev:3.16 (3.9%) stddev-sans-first:1.36 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: Values: 71.0 78.0 78.0 81.0 80.0 80.0 81.0 80.0 81.0 82.0 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:103.50 Median:105.50 stddev:4.03 (3.8%) stddev-sans-first:3.53 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: Values: 97.0 102.0 103.0 101.0 110.0 108.0 108.0 100.0 103.0 103.0 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:155.00 stddev:5.62 (3.6%) stddev-sans-first:4.53 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: Values: 145.0 153.0 164.0 155.0 153.0 155.0 153.0 153.0 163.0 160.0 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:184.50 stddev:7.85 (4.3%) stddev-sans-first:5.17 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: Values: 162.0 184.0 185.0 173.0 185.0 175.0 176.0 186.0 185.0 184.0 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: 12:29:15 INFO - 2015-11-12 12:29:15,292 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.80 Median:87.00 stddev:4.80 (5.5%) stddev-sans-first:3.55 12:29:15 INFO - 2015-11-12 12:29:15,293 DEBUG : BROWSER_OUTPUT: Values: 75.0 82.0 80.0 85.0 85.0 84.0 89.0 89.0 90.0 89.0 12:29:15 INFO - 2015-11-12 12:29:15,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:29:15 INFO - 2015-11-12 12:29:15,293 DEBUG : BROWSER_OUTPUT: 12:29:16 INFO - 2015-11-12 12:29:16,029 INFO : Browser exited with error code: 0 12:29:16 INFO - 2015-11-12 12:29:16,082 INFO : Completed test kraken (00:01:02) 12:29:16 INFO - 2015-11-12 12:29:16,082 INFO : Starting test v8_7 12:29:16 INFO - 2015-11-12 12:29:16,083 DEBUG : operating with platform_type : mac_ 12:29:16 INFO - 2015-11-12 12:29:16,083 INFO : Initialising browser for v8_7 test... 12:29:16 INFO - 2015-11-12 12:29:16,097 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp7yRSgi/profile http://localhost:49265/getInfo.html 12:29:19 INFO - 2015-11-12 12:29:19,468 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:29:19 INFO - 2015-11-12 12:29:19,468 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:29:19 INFO - 2015-11-12 12:29:19,468 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:29:19 INFO - 2015-11-12 12:29:19,468 DEBUG : BROWSER_OUTPUT: __metrics 12:29:20 INFO - 2015-11-12 12:29:20,150 INFO : Browser initialized. 12:29:20 INFO - 2015-11-12 12:29:20,150 INFO : Running cycle 1/1 for v8_7 test... 12:29:20 INFO - 2015-11-12 12:29:20,151 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/tmp7yRSgi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:29:32 INFO - 2015-11-12 12:29:32,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 239800320 12:29:32 INFO - 2015-11-12 12:29:32,434 DEBUG : BROWSER_OUTPUT: 12:29:54 INFO - 2015-11-12 12:29:54,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 260558848 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:29:55 INFO - 2015-11-12 12:29:55,243 DEBUG : BROWSER_OUTPUT: |0;Richards;180.83182640144665 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;213.4927412467976 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |2;Encrypt;355.7452863749555 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6568.6274509803925 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1275.5102040816328 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |5;Earley;899.2805755395683 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |6;Boyer;14492.753623188406 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |7;RegExp;33229.50819672131 12:29:55 INFO - 2015-11-12 12:29:55,244 DEBUG : BROWSER_OUTPUT: |8;Splay;757.002271006813 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6464.5161290322585 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1447360195236__endTimestamp 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,245 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:180.83 Median:180.83 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: Values: 180.8 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:213.49 Median:213.49 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: Values: 213.5 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:355.75 Median:355.75 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: Values: 355.7 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,246 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6568.63 Median:6568.63 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: Values: 6568.6 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1275.51 Median:1275.51 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: Values: 1275.5 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:899.28 Median:899.28 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: Values: 899.3 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,247 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14492.75 Median:14492.75 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: Values: 14492.8 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33229.51 Median:33229.51 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: Values: 33229.5 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:757.00 Median:757.00 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: Values: 757.0 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6464.52 Median:6464.52 stddev:0.00 (0.0%) 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: Values: 6464.5 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:29:55 INFO - 2015-11-12 12:29:55,248 DEBUG : BROWSER_OUTPUT: 12:29:55 INFO - 2015-11-12 12:29:55,967 INFO : Browser exited with error code: 0 12:29:55 INFO - 2015-11-12 12:29:55,989 INFO : Completed test v8_7 (00:00:39) 12:29:56 INFO - 2015-11-12 12:29:56,219 INFO : Completed test suite (00:20:16) 12:29:56 INFO - 2015-11-12 12:29:56,220 DEBUG : Working with test: dromaeo_css 12:29:56 INFO - 2015-11-12 12:29:56,220 DEBUG : Generating results file: dromaeo_css 12:29:56 INFO - 2015-11-12 12:29:56,220 DEBUG : Working with test: kraken 12:29:56 INFO - 2015-11-12 12:29:56,220 DEBUG : Generating results file: kraken 12:29:56 INFO - 2015-11-12 12:29:56,221 INFO : javascript benchmark 12:29:56 INFO - 2015-11-12 12:29:56,221 DEBUG : Working with test: v8_7 12:29:56 INFO - 2015-11-12 12:29:56,221 DEBUG : Generating results file: v8_7 12:29:56 INFO - 2015-11-12 12:29:56,221 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:29:56 INFO - 2015-11-12 12:29:56,281 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 12:29:56 INFO - 2015-11-12 12:29:56,281 DEBUG : process_Request line: dromaeo_css 5861.33 graph.html#tests=[[72,64,57]] 12:29:56 INFO - 2015-11-12 12:29:56,281 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:29:56 INFO - 2015-11-12 12:29:56,313 DEBUG : process_Request line: kraken 1792.40 graph.html#tests=[[232,64,57]] 12:29:56 INFO - 2015-11-12 12:29:56,314 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:29:56 INFO - 2015-11-12 12:29:56,353 DEBUG : process_Request line: v8_7 17426.98 graph.html#tests=[[230,64,57]] 12:29:56 INFO - 2015-11-12 12:29:56,354 INFO : javascript benchmark 12:29:56 INFO - 2015-11-12 12:29:56,356 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [292.2256021542911, 293.05635852554764, 299.2623183851805, 299.81561339776033, 304.1377694236839, 12933.224006559612, 13420.194788312709, 15135.697286054272, 15222.467213647511, 15769.605759855995, 15608.375664973388, 15760.0, 16251.349946002145, 16263.593410164753, 16510.917445412786, 4539.909201815962, 4914.287428322891, 4924.482929292427, 4926.630502712311, 4965.131102057126, 4152.0, 4227.260229459832, 4296.0548679290505, 4297.97851010746, 4723.858284251478, 4196.433481480007, 4230.19626271009, 4255.17024180285, 4284.164587905359, 4285.785710714467, 3995.9001024974464, 4109.547949725527, 4182.7490350578755, 4194.853180138696, 4263.424437700917, 3494.091536200581, 3511.473279008144, 3538.9115272118147, 3563.322968635977, 3565.964340356615, 11370.260933039408, 11534.0, 11545.365004924726, 11643.35961522116, 11733.120015998835, 1584.8335924727853, 1588.6743217640355, 1604.7592861070816, 1606.2611198848545, 1623.7564365345174, 8349.206825351583, 8372.83254334916, 8399.790005249857, 8406.159384061606, 8625.051244363114, 1331.567240646784, 1352.891768658505, 1354.613935028522, 1403.1510935883848, 1406.9577912662637, 48725.51274487245, 50346.0, 50654.49345506535, 51232.74383628058, 52097.73951130258, 5651.604387692904, 5735.569832262597, 5794.101914203306, 5802.854928626818, 5861.062230043258, 6620.569662971891, 6639.966800165968, 6643.302453242437, 6645.966770166118, 6658.933410665928, 4822.590079843182, 4847.2729090636685, 4848.612111031109, 4854.80580776765, 4896.192128298862, 5163.561097306696, 5182.689038657692, 5185.714785686823, 5197.8440646780655, 5229.346331708536, 2564.1538292363475, 2576.188500622298, 2597.6103584462103, 2602.2323414592743, 2610.7128215896237, 891.362675686874, 915.4324318922311, 935.4948327902993, 963.4460185393286, 987.3779518903045, 359.80031082748803, 387.5968992248087, 390.0424457955712, 400.18562225870215, 415.23803819990053, 9856.408615483095, 9964.800703986024, 10020.549075291628, 10045.849312260321, 10095.141912937483, 391.36207980990804, 396.04742692629065, 397.0292634508599, 404.1351507773367, 424.9915001700011, 5536.7785288588, 5593.944060559343, 5639.774409023593, 5649.180868774005, 5657.8019769307875, 449235.0, 454400.0, 456717.0, 457434.0, 460038.0, 61539.92300384963, 61748.0, 62666.373336266966, 62891.99999999908, 64051.35948640454, 443.9822407103744, 448.6007453366506, 449.3843434494763, 449.4202478802308, 450.4234579737941, 9412.435253884789, 9481.194098501705, 9546.093121153479, 9590.136887680143, 9628.566714497725, 28855.422891542472, 30365.848170759004, 30521.389572207987, 30736.231594210323, 30995.535066974466, 41636.375454367604, 41680.1663966725, 41977.580224197365, 42520.78739606282, 42941.355879661205, 5464.371597266365, 5467.39858615544, 5516.531094856982, 5568.582356323373, 5581.330240371181, 9875.851862221929, 10309.587616495257, 10350.120239779402, 10452.895471045496, 10537.789244215226, 7480.476366654282, 7621.466497345133, 8356.707515236938, 8827.293816494537, 8958.462492250486, 7594.278543538355, 7982.401319900914, 8023.157568455462, 8271.875921861298, 8318.958405207935, 8563.95718021431, 8585.484870907765, 8663.740087797376, 8761.956190219009, 8786.648534058566, 12309.0, 12502.187357821713, 13129.540466083641, 13217.867821321664, 13352.198868067948, 12911.483540658268, 13398.196108233537, 13416.865831341562, 13542.458301667823, 13787.724245515234], "dojo.html": [2721.129238643634, 2728.31792051987, 2749.2577004208856, 2795.776337892969, 2803.9859800700992, 4467.731936083833, 4592.311153327003, 4612.354270402142, 4684.086603112394, 4807.471178170407, 4643.16423043852, 4667.696599721015, 4672.182368085589, 4713.0, 4734.976325118379, 4317.956820431803, 4357.869263922072, 4453.265211240141, 4528.705634133771, 4536.954630453686, 4388.956110438887, 4398.670099742516, 4413.470383553978, 4413.7351758894565, 4421.204183247014, 4440.089781594766, 4443.777811109448, 4445.555444455561, 4447.799849006787, 4480.14877173336, 4245.405643209953, 4278.187144442546, 4339.47926248849, 4404.163208990313, 4441.866743997685, 4432.357308190327, 4444.488883778375, 4460.553944605514, 4462.085272519158, 4529.207388706963, 4416.911661766779, 4589.655775816794, 4631.884202894921, 4668.229742092551, 4703.482616912137, 4666.0901124280435, 4781.091592597395, 4787.904241915142, 4810.735409552473, 5034.798608055673, 4993.725345106018, 5121.820736274212, 5129.051125541787, 5143.871403214912, 5152.304438900738, 4577.176108300538, 4594.310853371954, 4758.809647614091, 4786.377770889762, 4829.492903245108, 5101.20931255656, 5111.412187598399, 5114.33513643224, 5120.769565369567, 5163.819266325736, 4953.2570114483115, 4963.503649635008, 4967.155583550805, 4967.180415231446, 5073.746312684351, 4904.828331008469, 4917.139500587383, 4933.50664933511, 4973.676711013773, 5156.432792392834, 4867.440244371872, 4984.4267909190185, 4993.50064993505, 4996.0, 5015.27278544609, 5019.121653710586, 5026.447090820006, 5029.698218106925, 5030.949690503048, 5032.345795046621, 3863.208042351311, 3899.200663863901, 3916.099297161669, 3936.6653834423823, 3979.6816254699556, 3564.9643503565153, 3581.8030008349792, 3605.603383627799, 3625.818709064536, 3630.7821530708243, 4687.343771871941, 4729.929051064168, 4740.2178640523925, 4770.332153498513, 4801.663883528119, 4954.752262386938, 5014.348134742533, 5034.723090230073, 5061.848144555669, 5063.924041139312, 4691.483936766953, 4760.928586071212, 4765.380500534978, 4805.6155507559315, 4877.146499362598, 4361.171377438277, 4485.215087359699, 4515.2324104902245, 4534.911621210952, 4648.697834640738, 5052.671576347526, 5061.468545802712, 5104.2343648453025, 5136.486351364833, 5150.948490515122, 5027.195648696191, 5072.1123803335, 5078.365204349457, 5104.132297509358, 5162.174052151638, 4975.427825799935, 5119.769610367468, 5128.000039992315, 5188.325517682677, 5208.322918020633, 4895.975520122377, 4950.282209079592, 4980.726060066731, 4995.200767877122, 5012.649114561946, 5021.6735912165595, 5120.25756265332, 5130.589552835839, 5184.248283998874, 5251.816186433456, 4717.693349932243, 4798.712077275374, 4853.854384368475, 4963.305137280856, 5008.123578373843, 4965.702057876539, 4986.127427700066, 4990.251462280687, 4993.400791904995, 5069.062223488666, 4735.21868891629, 4863.756812159449, 4867.318575399376, 4965.950340496694, 4994.350734404504, 4755.904881902274, 4877.048975449753, 4966.031623833318, 4979.651424400257, 5121.923171152361, 4877.12211801879, 4894.461609222912, 4919.262110683426, 4933.851984440473, 4935.629827763004], "mootools.html": [1463.15868375684, 1550.914699691517, 1562.4297131546982, 1568.7333153363927, 1594.163064391195, 6017.879642407149, 6407.743690252384, 6548.148740663713, 6920.238773734898, 7067.85864282714, 6504.121943537621, 6769.864602707943, 6771.4921380896385, 6790.796276111712, 6894.724211031566, 1850.3893715073993, 1877.3053970031108, 1892.8201820827069, 1908.2080936411373, 1915.3200613782117, 1920.0879582198484, 1933.0334832583708, 1936.5061909213132, 1964.1750464804816, 1979.21820880752, 1895.9431217063511, 1919.5585015446457, 1926.364299781076, 1944.1445763863926, 1952.0044777163678, 1870.326682394337, 1892.5174080609424, 1895.8862468251812, 1904.6381187574316, 1919.4529559075597, 1847.4919397165752, 1858.7490688757116, 1868.0846385271254, 1877.6995680691161, 1913.7416448779377, 6777.728890844361, 6782.355676210752, 6789.762358317435, 6804.11546498952, 6847.931520684829, 4046.8381264749373, 4122.237386083584, 4130.0500884796365, 4143.254214241435, 4173.6661067114865, 2188.9452763680874, 2214.2914267434426, 2324.721033475994, 2354.3054798834387, 2380.73811880693, 744.1219361153836, 771.7877583664481, 793.1552896165623, 803.8311954489506, 830.8753686946945, 9067.54662266884, 9103.499307538083, 9111.589978450986, 9137.725868223964, 9160.31297652672, 3527.488514165483, 3569.94645080324, 3653.0684675408133, 3721.6092310307567, 3742.6070262622034, 7760.379169666413, 7766.417518686008, 7784.883226751604, 7810.336121429742, 7924.326432253323, 4100.5899410058755, 4121.711480196357, 4158.064435501988, 4160.355144952538, 4201.264778663722, 3753.0804952786743, 3756.229972855558, 3772.9245415091546, 3781.2248489059675, 3825.081980324702, 3228.1445416964525, 3241.4651582489096, 3243.2864769750618, 3289.0626171540994, 3293.341331733615, 1061.686802393296, 1061.8991195836384, 1062.4050531702271, 1067.40758878823, 1080.098118071419, 1166.049669519339, 1174.48322737995, 1175.5474142455216, 1196.6469891382062, 1200.591798788416, 6320.810375688737, 6367.936320636827, 6453.580517266362, 6465.870682586416, 6469.0, 1010.075780660702, 1014.4268488304084, 1028.285341687535, 1028.408665017603, 1037.4397825174472, 5106.591472682251, 5152.201408781645, 5176.50823171798, 5194.11700010999, 5227.738613069331, 7378.483506154625, 7593.354564862048, 7890.0, 7936.365090792723, 8368.20502052304, 8088.797780055545, 8101.311388531923, 8123.7156699515235, 8127.959360203161, 8252.381071419668, 6292.653904035231, 6327.651979141099, 6492.577982431127, 6526.021096835512, 6590.406863382319, 6372.55392122547, 6427.068075129174, 6438.195225596801, 6496.70764815575, 6509.544331896911, 7075.929240707527, 7203.459740519377, 7206.639668016683, 7280.490365674564, 7333.413326933939, 7296.124465064227, 7400.481966262525, 7462.216467271075, 7478.551286922802, 7592.354649854824, 5813.215215945962, 5878.059510478303, 5886.558508111823, 5946.672932988728, 5955.880882382415, 6634.137562116894, 6641.634710090798, 6716.865662686621, 6724.327567243432, 6767.830804229934, 6293.118963345227, 6293.213348331458, 6340.207474065742, 6342.682865856781, 6352.872942541216, 6091.147239386578, 6137.048757442603, 6180.196574445294, 6253.718582663882, 6291.685415729286, 6249.593776404519, 6269.655168965751, 6283.37166283368, 6290.779822706183, 6375.0, 5599.776008959759, 5663.1788390682295, 5704.172894930295, 5742.712864356849, 5757.309122905278, 5694.943050569441, 5744.372910116252, 5782.624129431573, 5810.273715785527, 5811.389804070512], "ext.html": [464.87913142582937, 468.0194991492823, 475.3321583175637, 505.8128492457791, 520.648562220501, 33844.0, 34738.478922816175, 34858.119863219166, 34865.47701784472, 34945.65054349456, 36798.0, 37362.252754944886, 37383.0, 37418.625813741855, 37425.81287093561, 8247.257746802787, 8360.0, 8451.83096338073, 8458.323334133254, 8465.703700370488, 8164.265216130547, 8192.467489613186, 8200.958995205016, 8318.126596707349, 8324.167583241688, 8211.876821847676, 8233.21784430481, 8334.66661333549, 8338.207870252316, 8359.164083591653, 8149.755507334789, 8268.545230012347, 8278.668853245863, 8390.286825619829, 8399.62201700925, 7962.044554653478, 8019.518828870228, 8027.15714849944, 8158.673653053871, 8159.796005099861, 34512.654873451196, 34546.48180277298, 34640.480392794125, 34698.82650586756, 35037.64962350369, 2697.9055733049445, 2712.1185614675114, 2712.4168303814777, 2743.0, 2743.1084897408223, 23933.162339318213, 24359.269221923372, 25413.618795718077, 26015.21954341373, 26372.208833735018, 1999.990000050005, 2097.737782777153, 2109.6202683516963, 2123.5434381607874, 2201.0755482697305, 248816.0, 253624.0, 257407.0, 257524.0, 259976.0, 45624.0, 46980.5301946983, 55430.44569554253, 57937.130943035045, 59635.701821491486, 53620.19569706458, 53621.463785361644, 53820.461795382325, 54229.0, 54425.0, 14161.504347347793, 14199.71600567983, 14255.78616320756, 14285.0, 14347.497837575635, 10645.308054976556, 10665.146788256921, 10722.839157412645, 10743.78512429747, 10751.0, 17669.0, 17725.822741772674, 17761.46715598534, 17835.910820446075, 17931.462056138338, 7397.8150546236775, 7738.380929525737, 7739.729109481141, 7744.961275193588, 7758.456908016497, 839.2404873589411, 874.9212570868652, 898.6495266845935, 923.9743884288434, 975.5219942228257, 24306.27081187567, 24588.262352129466, 24719.62920556193, 24759.133430329854, 24766.0, 910.7632015675839, 915.0986278515657, 920.0385597051097, 921.2814005076051, 933.4819175357605, 12338.259704417764, 12566.748665026831, 12575.622731318075, 12743.745125097632, 12784.105112642212, 339299.0, 348065.0, 348252.0, 349926.0, 351483.0, 47896.0, 48062.51937480651, 48117.66940975329, 48148.0, 48259.276110858365, 1180.9527618895147, 1185.4783895086134, 1190.9404529773476, 1193.7254431480808, 1201.1351826684772, 23759.52480950406, 27233.455330893667, 27331.0, 28306.0, 28493.145205643865, 43698.781506092266, 43904.0, 44441.777791110835, 44529.332060018474, 44551.55448445474, 251276.0, 254645.0, 254802.0, 254936.0, 256974.0, 35947.82026089853, 36899.446508302935, 37360.626393735714, 37907.62092379151, 37940.395662412026, 35970.28059438849, 37594.0, 37902.24195516129, 38377.61622383852, 38569.228615428096, 31287.84356078205, 31503.0, 31591.0, 31736.523952141197, 32253.677463225067, 31674.841625791723, 34353.31293374168, 35304.29391412106, 35543.64456355404, 35821.64178358183, 35107.29785404329, 35113.122171945906, 35604.64395356013, 36075.81962090278, 36149.457758133125, 26236.344091397867, 27509.17472475829, 28298.71701282961, 28407.573886391307, 28632.856835715687, 21434.89282553577, 21815.018324175133, 21818.781812181674, 21884.12463501442, 21912.342629721134], "prototype.html": [273.7399470503022, 274.68960075115115, 278.55709422018975, 280.90870467098193, 280.98595070246506, 5333.546648534879, 5388.084025715628, 5419.430959749224, 5493.478119578644, 5539.667619942807, 5306.840794776153, 5330.3603567571945, 5372.57019438445, 5386.596005299599, 5418.593605479585, 4166.729162604436, 4170.1242739024765, 4213.683973701969, 4238.152369526092, 4244.236037513262, 4200.201961627296, 4207.095474472988, 4213.073123912734, 4222.239996800575, 4233.851815186469, 4043.5147782266167, 4153.667706583481, 4155.6883233757435, 4159.376093585971, 4204.600562946515, 4170.937435938464, 4176.958230417687, 4200.936985945214, 4229.894252643693, 4232.746035237865, 3613.8554457821656, 3640.690541303992, 3677.42999835026, 3680.2639472105684, 3688.5573731152167, 5243.318368612094, 5274.340707411574, 5289.814856480005, 5314.362276526803, 5342.652727572696, 4482.8431004915, 4523.47979982303, 4592.908141837178, 4593.678442509025, 4596.701214421052, 5603.971980140073, 5658.490735833795, 5661.490465858093, 5664.0, 5741.827745167651, 3748.662620364153, 3771.208046310278, 3786.734928555002, 3789.5452545694416, 3797.715171362159, 5730.656160630376, 5779.9422005779825, 5865.736041878125, 5874.148248503986, 5933.792317268918, 3752.043228976648, 3770.472133901256, 3783.2622638585212, 3808.4668146459517, 3835.137094153793, 3834.0, 3843.7885916274313, 3859.4789703390243, 3902.70729695274, 3909.706771992055, 4489.214387482243, 4498.932516012263, 4504.752238626907, 4554.749488778083, 4582.991741816795, 5548.167774833807, 5660.235868157828, 5698.1452782083015, 5746.224259724883, 5773.39379365169, 1384.2940100548592, 1408.5985494134122, 1410.9223992680502, 1422.7510185717665, 1424.095699230975, 894.1505569708803, 899.7975455522586, 909.9317551183556, 910.9407888487227, 921.8893732752113, 5403.540699040625, 5428.5928555358505, 5487.780488780404, 5495.642783219078, 5522.337319521603, 5936.910946335808, 5971.373005834412, 5985.191999080155, 6004.699765011732, 6049.667268300285, 5409.702466364309, 5426.348838139448, 5485.780568777284, 5504.174373843955, 5518.172274158908, 3186.3149422874194, 3300.471924492118, 3311.6853898879567, 3313.2213929726495, 3317.369699757087, 6030.517558595302, 6054.636721796706, 6061.454469097803, 6074.9392506075255, 6117.143599896018, 5859.589828711949, 5956.136360227742, 6059.8485037873525, 6066.029435290332, 6111.57218994675, 6039.66781826995, 6047.9395206047375, 6068.575199735976, 6070.605410648293, 6079.0273556230795, 5951.22634057587, 5954.672493012926, 5960.105984102419, 5962.2249107615735, 5966.164736936746, 5701.743421545957, 5767.567432442667, 5792.420757924174, 5793.623414478046, 5853.268341457318, 6023.45788879003, 6030.969845150747, 6042.8791424170395, 6048.758049677964, 6101.572889897665, 3733.234686889127, 3778.471014057979, 3785.2966165226308, 3786.5266841644793, 3790.166163444038, 5771.769129234952, 5924.4667979882015, 5930.555208359304, 5935.643861368331, 5944.048952167633, 5791.53667706574, 5801.3038435388025, 5891.293044834647, 5895.911561326498, 5914.319853216935, 5817.272840894888, 5868.735906884115, 5884.705764711833, 5891.823245302648, 5894.528437724886, 5704.885902281848, 5719.542436605145, 5735.283089613798, 5739.5695322850115, 5743.3395159557185, 5694.601377903673, 5854.0340843760305, 5856.267966504187, 5869.73586188614, 5874.17761513397, 5757.453041961007, 5766.163906233656, 5768.163616275533, 5783.884322313615, 5816.76732930678], "yui.html": [647.8186107889793, 651.5764752910608, 661.6592454885733, 685.2051620120661, 696.2689176364817, 12024.33866137362, 12429.31638759868, 12470.37648117595, 12470.750584988295, 12472.625821225354, 11421.600243991463, 12300.753984920297, 12502.499900004012, 12666.0, 12677.936610316936, 594.4174708785393, 603.8067818298147, 755.5164694595463, 758.6510205305566, 771.240328276647, 756.0549313358302, 756.8486302739474, 758.6434375843345, 759.350755104386, 770.4144849914078, 744.7653988993477, 776.9300762931335, 792.1800936031209, 801.2788490358665, 803.0203152154362, 739.6671497826, 783.5572901310769, 786.6813940354166, 791.6595863778573, 791.7387262203459, 568.3691102875805, 571.2545128607165, 574.2936188488142, 574.7499837570671, 574.9798757043484, 11919.702007449796, 12059.577914773028, 12068.215565988183, 12072.456739446747, 12304.630861074182, 8308.29379502737, 8332.7083552076, 8432.40973131881, 8733.868991965062, 8825.867611985825, 7648.0, 8187.140350263256, 8207.876881846778, 8259.752207433787, 8473.830523389497, 2662.5739881619043, 2666.3067602423316, 2719.3473566344132, 2771.2794673384865, 2773.1126039667315, 41188.58811411878, 42126.36810447846, 42172.78913605443, 42478.57521424777, 42612.3608145878, 5764.337101233328, 6018.849528761816, 6033.245844269466, 6126.356732543108, 6356.173697419398, 10241.94879025615, 10325.535350909227, 10330.431826249478, 10375.325603835727, 10456.477176141163, 5507.366652834895, 5510.0, 5513.145462453326, 5582.134769110794, 5697.202391665171, 3253.3330667213163, 3325.1687078230443, 3339.93320133596, 3398.4222682144095, 3581.301646179022, 2329.0101706774553, 2359.7876191142877, 2361.2089949866986, 2388.4028992751814, 2404.0624156578947, 346.34540718042916, 348.9511468394427, 349.8023616656581, 356.9375359312162, 364.58437381385244, 456.7738969210262, 479.549223729693, 492.5271739130403, 511.872031992002, 545.0080852847778, 6748.561343512656, 7229.457790665721, 7294.416446684252, 7305.744298949511, 7339.339459448568, 428.14584903118475, 521.5045706578766, 525.9710715910662, 547.635822178255, 551.9595562364971, 3325.451300535433, 3368.4105281575626, 3391.7117045051446, 3495.2310491691787, 3515.1739341254784, 52836.0, 52846.73576632169, 53018.20472692913, 53032.204516932274, 53525.732371337894, 44655.776721116184, 45260.0, 45273.773631132295, 45448.0, 45556.0, 38650.0, 38665.42001869974, 39105.80447097803, 40853.38719919204, 41346.1730765389, 7046.2249152594195, 7292.817679558054, 7310.59791711461, 7335.669894854637, 7522.623868806429, 29924.0, 30043.513842592227, 30246.84876575603, 30438.391232175676, 30789.846050769604, 37226.255474890895, 37260.627393725714, 37873.81063094667, 40835.38746918858, 40842.59157408507, 6569.9014514783275, 6653.434458071119, 6715.664216789043, 6815.079964204769, 6878.828029299308, 9469.621215151317, 9488.573014214515, 9661.951690241503, 9892.901070989197, 10365.118964887768, 9163.541822908961, 9324.228634245748, 9361.85957210656, 9478.763030924281, 9526.380785248937, 8977.10228977097, 9054.411463254868, 9278.72163835086, 9402.247820174507, 9484.336096473457, 8584.313254939465, 8676.089010654043, 8822.5588720565, 9228.169464748205, 9263.397879137834, 7738.883916741366, 7745.728899488491, 7802.726904558313, 8145.81885626569, 8178.100408955129, 7168.53404528704, 7452.180260171268, 7929.365650747811, 8035.156308587748, 8223.383246256435]}, "summary": {"lowerIsBetter": false, "suite": 5861.326098791083, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6095.441638846872, "unit": "ms", "value": 6095.441638846872}, "dojo.html": {"lowerIsBetter": false, "filtered": 4669.536453507748, "unit": "ms", "value": 4669.536453507748}, "mootools.html": {"lowerIsBetter": false, "filtered": 3919.7853189264715, "unit": "ms", "value": 3919.7853189264715}, "ext.html": {"lowerIsBetter": false, "filtered": 16661.16695573219, "unit": "ms", "value": 16661.16695573219}, "prototype.html": {"lowerIsBetter": false, "filtered": 4279.226432187818, "unit": "ms", "value": 4279.226432187818}, "yui.html": {"lowerIsBetter": false, "filtered": 5097.064912896229, "unit": "ms", "value": 5097.064912896229}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0101.e"}, "testrun": {"date": 1447358979, "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": "20151112102147", "branch": "Fx-Team", "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc"}}, {"talos_counters": {}, "results": {"audio-dft": [186.0, 193.0, 208.0, 201.0, 192.0, 192.0, 193.0, 193.0, 198.0, 195.0], "ai-astar": [116.0, 108.0, 119.0, 115.0, 117.0, 129.0, 127.0, 127.0, 128.0, 128.0], "imaging-gaussian-blur": [136.0, 135.0, 149.0, 145.0, 138.0, 143.0, 149.0, 140.0, 143.0, 136.0], "audio-beat-detection": [192.0, 165.0, 176.0, 186.0, 157.0, 178.0, 180.0, 150.0, 189.0, 158.0], "json-stringify-tinderbox": [71.0, 78.0, 78.0, 81.0, 80.0, 80.0, 81.0, 80.0, 81.0, 82.0], "stanford-crypto-pbkdf2": [162.0, 184.0, 185.0, 173.0, 185.0, 175.0, 176.0, 186.0, 185.0, 184.0], "json-parse-financial": [68.0, 68.0, 71.0, 73.0, 74.0, 75.0, 76.0, 80.0, 73.0, 73.0], "stanford-crypto-sha256-iterative": [75.0, 82.0, 80.0, 85.0, 85.0, 84.0, 89.0, 89.0, 90.0, 89.0], "audio-fft": [79.0, 84.0, 94.0, 132.0, 81.0, 82.0, 85.0, 86.0, 137.0, 79.0], "imaging-darkroom": [149.0, 149.0, 156.0, 153.0, 148.0, 149.0, 150.0, 149.0, 150.0, 149.0], "stanford-crypto-ccm": [145.0, 153.0, 164.0, 155.0, 153.0, 155.0, 153.0, 153.0, 163.0, 160.0], "audio-oscillator": [98.0, 104.0, 145.0, 105.0, 106.0, 104.0, 143.0, 104.0, 104.0, 147.0], "stanford-crypto-aes": [97.0, 102.0, 103.0, 101.0, 110.0, 108.0, 108.0, 100.0, 103.0, 103.0], "imaging-desaturate": [122.0, 128.0, 127.0, 125.0, 127.0, 127.0, 122.0, 122.0, 130.0, 128.0]}, "summary": {"lowerIsBetter": true, "suite": 1792.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.9, "unit": "ms", "value": 93.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 179.5, "unit": "ms", "value": 179.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 173.1, "unit": "ms", "value": 173.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 155.4, "unit": "ms", "value": 155.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 150.2, "unit": "ms", "value": 150.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.1, "unit": "ms", "value": 73.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 116.0, "unit": "ms", "value": 116.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 121.4, "unit": "ms", "value": 121.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 195.1, "unit": "ms", "value": 195.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 84.8, "unit": "ms", "value": 84.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 141.4, "unit": "ms", "value": 141.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 103.5, "unit": "ms", "value": 103.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 125.8, "unit": "ms", "value": 125.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0101.e"}, "testrun": {"date": 1447358979, "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": "20151112102147", "branch": "Fx-Team", "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc"}}, {"talos_counters": {}, "results": {"DeltaBlue": [213.4927412467976], "Encrypt": [355.7452863749555], "NavierStokes": [6464.5161290322585], "Decrypt": [6568.6274509803925], "Splay": [757.002271006813], "Richards": [180.83182640144665], "RegExp": [33229.50819672131], "Earley": [899.2805755395683], "Boyer": [14492.753623188406], "RayTrace": [1275.5102040816328]}, "summary": {"lowerIsBetter": false, "suite": 17426.983508327576, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 309.6967119999999, "unit": "score", "value": 309.6967119999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 748.2347909999999, "unit": "score", "value": 748.2347909999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 229.56087824351292, "unit": "score", "value": 229.56087824351292}, "Decrypt": {"lowerIsBetter": false, "filtered": 40.52307761194031, "unit": "score", "value": 40.52307761194031}, "Splay": {"lowerIsBetter": false, "filtered": 107.64961099999998, "unit": "score", "value": 107.64961099999998}, "RegExp": {"lowerIsBetter": false, "filtered": 27.41494079921067, "unit": "score", "value": 27.41494079921067}, "Richards": {"lowerIsBetter": false, "filtered": 195.22006000000002, "unit": "score", "value": 195.22006000000002}, "Earley": {"lowerIsBetter": false, "filtered": 741.1068559999998, "unit": "score", "value": 741.1068559999998}, "Boyer": {"lowerIsBetter": false, "filtered": 45.985947000000024, "unit": "score", "value": 45.985947000000024}, "RayTrace": {"lowerIsBetter": false, "filtered": 580.1513759999997, "unit": "score", "value": 580.1513759999997}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0101.e"}, "testrun": {"date": 1447358979, "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": "20151112102147", "branch": "Fx-Team", "revision": "6aff4aa8f3dee8b902434e572b65b4eff40d00dc"}}] 12:29:56 INFO - RETURN: dromaeo_css: 5861.33 12:29:56 INFO - RETURN: kraken: 1792.40 12:29:56 INFO - RETURN: v8_7: 17426.98 12:29:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "17426.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1792.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5861.33"}}} 12:29:56 INFO - Return code: 0 12:29:56 INFO - # TBPL SUCCESS # 12:29:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:56 INFO - 2015-11-12 12:29:56.451 screenresolution[1656:10753] starting screenresolution argv=screenresolution get 12:29:56 INFO - 2015-11-12 12:29:56.455 screenresolution[1656:10753] Display 0: 1600x1200x32@60 12:29:56 INFO - 2015-11-12 12:29:56.461 screenresolution[1657:10756] starting screenresolution argv=screenresolution list 12:29:56 INFO - Available Modes on Display 0 12:29:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:56 INFO - Intel HD Graphics 3000: 12:29:56 INFO - Chipset Model: Intel HD Graphics 3000 12:29:56 INFO - Type: GPU 12:29:56 INFO - Bus: Built-In 12:29:56 INFO - VRAM (Total): 512 MB 12:29:56 INFO - VRAM (Dynamic, Max): 10 12:29:56 INFO - Vendor: Intel (0x8086) 12:29:56 INFO - Device ID: 0x0116 12:29:56 INFO - Revision ID: 0x0009 12:29:56 INFO - Displays: 12:29:56 INFO - Display: 12:29:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:56 INFO - Display Serial Number: 1600x1200 60 12:29:56 INFO - Main Display: Yes 12:29:56 INFO - Mirror: Off 12:29:56 INFO - Online: Yes 12:29:56 INFO - Rotation: Supported 12:29:56 INFO - Return code: 0 12:29:56 INFO - Running post-action listener: _resource_record_post_action 12:29:56 INFO - Running post-run listener: _resource_record_post_run 12:29:57 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 41747456; Write bytes: 692115456; Read time: 5577; Write time: 81407 12:29:57 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 342995456; Write bytes: 342308864; Read time: 35740; Write time: 7640 12:29:57 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 39465984; Write bytes: 345579520; Read time: 5076; Write time: 69497 12:29:57 INFO - Running post-run listener: _upload_blobber_files 12:29:57 INFO - Blob upload gear active. 12:29:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:29:57 INFO - Copying logs to upload dir... 12:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1322.098284 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-12 12:29:57.884721) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 12:29:57.888212) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010252 build_url: 'https://queue.taskcluster.net/v1/task/USG53aW_Q6uJu_lD_WcT3w/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-12 12:29:57.914703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:29:57.915052) ========= 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.3XJ8Zuulz3/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.9O4UONWck0/Listeners TMPDIR=/var/folders/p8/bl0pvbgn7c3g09bn9lhsnjvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005533 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 12:29:57.964649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 12:29:57.965001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 12:29:57.965484) ========= ========= Total master_lag: 0.23 =========