builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0033 starttime: 1447702825.04 results: success (0) buildid: 20151116095835 builduid: c128097a68774eda97fd6b30f2d3adc1 revision: 647f70a15615ce77b1eb74bd73df36a35576bc93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.045068) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.045581) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.045921) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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.006074 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.135769) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.136131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.158754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.159173) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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.028092 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.208898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.209304) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.209751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.210097) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 11:40:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-16 11:40:25 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.354233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.354544) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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.103994 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.473576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:25.474041) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 647f70a15615ce77b1eb74bd73df36a35576bc93 --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 647f70a15615ce77b1eb74bd73df36a35576bc93 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 11:40:25,578 truncating revision to first 12 chars 2015-11-16 11:40:25,578 Setting DEBUG logging. 2015-11-16 11:40:25,578 attempt 1/10 2015-11-16 11:40:25,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/647f70a15615?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 11:40:25,867 unpacking tar archive at: fx-team-647f70a15615/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:26.077498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:26.077831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:26.091846) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:26.092195) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 11:40:26.092646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-16 11:40:26.092935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:40:26 INFO - MultiFileLogger online at 20151116 11:40:26 in /builds/slave/test 11:40:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:40:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:26 INFO - {'append_to_log': False, 11:40:26 INFO - 'base_work_dir': '/builds/slave/test', 11:40:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:40:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:26 INFO - 'branch': 'Fx-Team', 11:40:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:26 INFO - 'config_files': ('talos/mac_config.py',), 11:40:26 INFO - 'default_actions': ('clobber', 11:40:26 INFO - 'read-buildbot-config', 11:40:26 INFO - 'download-and-extract', 11:40:26 INFO - 'populate-webroot', 11:40:26 INFO - 'create-virtualenv', 11:40:26 INFO - 'install', 11:40:26 INFO - 'run-tests'), 11:40:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:26 INFO - 'download_minidump_stackwalk': True, 11:40:26 INFO - 'download_symbols': 'ondemand', 11:40:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:26 INFO - 'installer_path': 'installer.exe', 11:40:26 INFO - 'log_level': 'info', 11:40:26 INFO - 'log_name': 'talos', 11:40:26 INFO - 'log_to_console': True, 11:40:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:40:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:40:26 INFO - 'opt_config_files': (), 11:40:26 INFO - 'pip_index': False, 11:40:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:40:26 INFO - 'cmd': ('bash', 11:40:26 INFO - '-c', 11:40:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:40:26 INFO - 'enabled': True, 11:40:26 INFO - 'halt_on_failure': False, 11:40:26 INFO - 'name': 'check_screen_resolution'},), 11:40:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:40:26 INFO - 'cmd': ('bash', 11:40:26 INFO - '-c', 11:40:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:40:26 INFO - 'enabled': True, 11:40:26 INFO - 'halt_on_failure': False, 11:40:26 INFO - 'name': 'check_screen_resolution'},), 11:40:26 INFO - 'run_cmd_checks_enabled': True, 11:40:26 INFO - 'sps_profile': False, 11:40:26 INFO - 'sps_profile_interval': 0, 11:40:26 INFO - 'suite': 'dromaeojs', 11:40:26 INFO - 'system_bits': '64', 11:40:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:26 INFO - 'title': 't-yosemite-r5-0033', 11:40:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:26 INFO - 'use_talos_json': True, 11:40:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:26 INFO - 'work_dir': 'build'} 11:40:26 INFO - ##### 11:40:26 INFO - ##### Running clobber step. 11:40:26 INFO - ##### 11:40:26 INFO - Running pre-action listener: _resource_record_pre_action 11:40:26 INFO - Running main action method: clobber 11:40:26 INFO - rmtree: /builds/slave/test/build 11:40:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:30 INFO - Running post-action listener: _resource_record_post_action 11:40:30 INFO - ##### 11:40:30 INFO - ##### Running read-buildbot-config step. 11:40:30 INFO - ##### 11:40:30 INFO - Running pre-action listener: _resource_record_pre_action 11:40:30 INFO - Running main action method: read_buildbot_config 11:40:30 INFO - Using buildbot properties: 11:40:30 INFO - { 11:40:30 INFO - "properties": { 11:40:30 INFO - "buildnumber": 1237, 11:40:30 INFO - "product": "firefox", 11:40:30 INFO - "script_repo_revision": "production", 11:40:30 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 11:40:30 INFO - "repository": "", 11:40:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 11:40:30 INFO - "buildid": "20151116095835", 11:40:30 INFO - "slavename": "t-yosemite-r5-0033", 11:40:30 INFO - "pgo_build": "False", 11:40:30 INFO - "basedir": "/builds/slave/test", 11:40:30 INFO - "project": "", 11:40:30 INFO - "platform": "yosemite", 11:40:30 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:40:30 INFO - "slavebuilddir": "test", 11:40:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:40:30 INFO - "branch": "fx-team", 11:40:30 INFO - "repo_path": "integration/fx-team", 11:40:30 INFO - "stage_platform": "macosx64", 11:40:30 INFO - "builduid": "c128097a68774eda97fd6b30f2d3adc1", 11:40:30 INFO - "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93" 11:40:30 INFO - }, 11:40:30 INFO - "sourcestamp": { 11:40:30 INFO - "repository": "", 11:40:30 INFO - "hasPatch": false, 11:40:30 INFO - "project": "", 11:40:30 INFO - "branch": "fx-team-macosx64-talos", 11:40:30 INFO - "changes": [ 11:40:30 INFO - { 11:40:30 INFO - "category": null, 11:40:30 INFO - "files": [ 11:40:30 INFO - { 11:40:30 INFO - "url": null, 11:40:30 INFO - "name": "https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:40:30 INFO - } 11:40:30 INFO - ], 11:40:30 INFO - "repository": "", 11:40:30 INFO - "rev": "647f70a15615ce77b1eb74bd73df36a35576bc93", 11:40:30 INFO - "who": "mbanner@mozilla.com", 11:40:30 INFO - "when": 1447702375, 11:40:30 INFO - "number": 6667388, 11:40:30 INFO - "comments": "Bug 1224556 - Default fallback icon for Loop's rooms with no context is no longer displayed. r=mikedeboer", 11:40:30 INFO - "project": "", 11:40:30 INFO - "at": "Mon 16 Nov 2015 11:32:55", 11:40:30 INFO - "branch": "fx-team-macosx64-talos", 11:40:30 INFO - "revlink": "", 11:40:30 INFO - "properties": [ 11:40:30 INFO - [ 11:40:30 INFO - "buildid", 11:40:30 INFO - "20151116095835", 11:40:30 INFO - "Change" 11:40:30 INFO - ], 11:40:30 INFO - [ 11:40:30 INFO - "builduid", 11:40:30 INFO - "c128097a68774eda97fd6b30f2d3adc1", 11:40:30 INFO - "Change" 11:40:30 INFO - ], 11:40:30 INFO - [ 11:40:30 INFO - "pgo_build", 11:40:30 INFO - "False", 11:40:30 INFO - "Change" 11:40:30 INFO - ] 11:40:30 INFO - ], 11:40:30 INFO - "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93" 11:40:30 INFO - } 11:40:30 INFO - ], 11:40:30 INFO - "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93" 11:40:30 INFO - } 11:40:30 INFO - } 11:40:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:40:30 INFO - Running post-action listener: _resource_record_post_action 11:40:30 INFO - ##### 11:40:30 INFO - ##### Running download-and-extract step. 11:40:30 INFO - ##### 11:40:30 INFO - Running pre-action listener: _resource_record_pre_action 11:40:30 INFO - Running main action method: download_and_extract 11:40:30 INFO - mkdir: /builds/slave/test/build/tests 11:40: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')]} 11:40:30 INFO - https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:40:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/test_packages.json 11:40:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/test_packages.json 11:40:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:40:31 INFO - Downloaded 1149 bytes. 11:40:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:40:31 INFO - Using the following test package requirements: 11:40:31 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:40:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:40:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'jsshell-mac.zip'], 11:40:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:40:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:40:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:40:31 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:40:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:40:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:40:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:40:31 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:40:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:40: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')]} 11:40:31 INFO - https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:32 INFO - Downloaded 17464075 bytes. 11:40:32 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 11:40:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:40:38 INFO - Return code: 0 11:40:38 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 11:40: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')]} 11:40:38 INFO - https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:39 INFO - Downloaded 17464075 bytes. 11:40:39 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 11:40:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:40:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:40:45 INFO - Return code: 0 11:40:45 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')]} 11:40:45 INFO - https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:40:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:40:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:40:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:46 INFO - Downloaded 11131693 bytes. 11:40:46 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 11:40:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:40:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:40:47 INFO - Return code: 0 11:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:47 INFO - https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOZhJfqnT564bvy0MHnh9g/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 11:40:51 INFO - Downloaded 108679972 bytes. 11:40:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:40:51 INFO - mkdir: /builds/slave/test/properties 11:40:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:51 INFO - Contents: 11:40:51 INFO - build_url:https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:40:51 INFO - Running post-action listener: _resource_record_post_action 11:40:51 INFO - Running post-action listener: set_extra_try_arguments 11:40:51 INFO - ##### 11:40:51 INFO - ##### Running populate-webroot step. 11:40:51 INFO - ##### 11:40:51 INFO - Running pre-action listener: _resource_record_pre_action 11:40:51 INFO - Running main action method: populate_webroot 11:40:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:40:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:40:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:40:51 INFO - '../fennec_ids.txt'], 11:40:51 INFO - 'tests': ['tcheck2']}, 11:40:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:40:51 INFO - '--tppagecycles', 11:40:51 INFO - '7'], 11:40:51 INFO - 'tests': ['tsvgm']}}, 11:40:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:40:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:40:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:40:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:40:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['damp', 'tps']}, 11:40:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['damp', 'tps']}, 11:40:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:40:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:51 INFO - 'other': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'other_l64': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'other_nol64': {'tests': ['a11yr', 11:40:51 INFO - 'ts_paint', 11:40:51 INFO - 'tpaint', 11:40:51 INFO - 'sessionrestore', 11:40:51 INFO - 'sessionrestore_no_auto_restore']}, 11:40:51 INFO - 'svgr': {'tests': ['tsvgx', 11:40:51 INFO - 'tsvgr_opacity', 11:40:51 INFO - 'tart', 11:40:51 INFO - 'tscrollx', 11:40:51 INFO - 'cart']}, 11:40:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['tsvgx', 11:40:51 INFO - 'tsvgr_opacity', 11:40:51 INFO - 'tart', 11:40:51 INFO - 'tscrollx', 11:40:51 INFO - 'cart']}, 11:40:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'tests': ['tp5o']}, 11:40:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--e10s'], 11:40:51 INFO - 'tests': ['tp5o']}, 11:40:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--xperf_path', 11:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:51 INFO - 'tests': ['tp5n']}, 11:40:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:51 INFO - 'talos_options': ['--e10s', 11:40:51 INFO - '--xperf_path', 11:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:51 INFO - 'tests': ['tp5n']}}, 11:40:51 INFO - 'talos.zip': {'path': '', 11:40:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:40:51 INFO - Running post-action listener: _resource_record_post_action 11:40:51 INFO - ##### 11:40:51 INFO - ##### Running create-virtualenv step. 11:40:51 INFO - ##### 11:40:51 INFO - Running pre-action listener: _resource_record_pre_action 11:40:51 INFO - Running main action method: create_virtualenv 11:40:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:51 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 11:40:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:40:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:51 INFO - Using real prefix '/tools/python27' 11:40:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:58 INFO - Installing pip.................done. 11:40:58 INFO - Return code: 0 11:40:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:58 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')]} 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 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')]} 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:40:58 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 11:40:58 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 11:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:58 INFO - 'HOME': '/Users/cltbld', 11:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:58 INFO - 'LOGNAME': 'cltbld', 11:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:58 INFO - 'MOZ_NO_REMOTE': '1', 11:40:58 INFO - 'NO_EM_RESTART': '1', 11:40:58 INFO - 'PAGER': '/bin/cat', 11:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:58 INFO - 'PWD': '/builds/slave/test', 11:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:58 INFO - 'SHELL': '/bin/bash', 11:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:40:58 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:58 INFO - 'USER': 'cltbld', 11:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:58 INFO - 'XPC_FLAGS': '0x0', 11:40:58 INFO - 'XPC_SERVICE_NAME': '0', 11:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:58 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 11:40:58 INFO - Cleaning up... 11:40:58 INFO - Return code: 0 11:40:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:40:58 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')]} 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 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')]} 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:58 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:40:58 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 11:40:58 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 11:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:58 INFO - 'HOME': '/Users/cltbld', 11:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:58 INFO - 'LOGNAME': 'cltbld', 11:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:58 INFO - 'MOZ_NO_REMOTE': '1', 11:40:58 INFO - 'NO_EM_RESTART': '1', 11:40:58 INFO - 'PAGER': '/bin/cat', 11:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:58 INFO - 'PWD': '/builds/slave/test', 11:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:58 INFO - 'SHELL': '/bin/bash', 11:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:40:58 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:58 INFO - 'USER': 'cltbld', 11:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:58 INFO - 'XPC_FLAGS': '0x0', 11:40:58 INFO - 'XPC_SERVICE_NAME': '0', 11:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:58 INFO - Downloading/unpacking psutil>=0.7.1 11:40:58 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 11:40:58 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 11:40:58 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 11:40:58 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 11:40:58 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 11:40:58 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 11:41:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:41:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:02 INFO - Installing collected packages: psutil 11:41:02 INFO - Running setup.py install for psutil 11:41:02 INFO - building 'psutil._psutil_osx' extension 11:41:02 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 11:41:04 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 11:41:04 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 11:41:04 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 11:41:04 INFO - building 'psutil._psutil_posix' extension 11:41:04 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 11:41:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:41:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:41:04 INFO - ^ 11:41:04 INFO - 1 warning generated. 11:41:04 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 11:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:04 INFO - Successfully installed psutil 11:41:04 INFO - Cleaning up... 11:41:05 INFO - Return code: 0 11:41:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:05 INFO - 'HOME': '/Users/cltbld', 11:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:05 INFO - 'LOGNAME': 'cltbld', 11:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:05 INFO - 'MOZ_NO_REMOTE': '1', 11:41:05 INFO - 'NO_EM_RESTART': '1', 11:41:05 INFO - 'PAGER': '/bin/cat', 11:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:05 INFO - 'PWD': '/builds/slave/test', 11:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:05 INFO - 'SHELL': '/bin/bash', 11:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:41:05 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:05 INFO - 'USER': 'cltbld', 11:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:05 INFO - 'XPC_FLAGS': '0x0', 11:41:05 INFO - 'XPC_SERVICE_NAME': '0', 11:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:41:05 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 11:41:05 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 11:41:05 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 11:41:05 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 11:41:05 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 11:41:05 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 11:41:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:41:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:41:08 INFO - Installing collected packages: mozsystemmonitor 11:41:08 INFO - Running setup.py install for mozsystemmonitor 11:41:08 INFO - Successfully installed mozsystemmonitor 11:41:08 INFO - Cleaning up... 11:41:08 INFO - Return code: 0 11:41:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:41:08 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')]} 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 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')]} 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:41:08 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 11:41:08 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 11:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:08 INFO - 'HOME': '/Users/cltbld', 11:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:08 INFO - 'LOGNAME': 'cltbld', 11:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:08 INFO - 'MOZ_NO_REMOTE': '1', 11:41:08 INFO - 'NO_EM_RESTART': '1', 11:41:08 INFO - 'PAGER': '/bin/cat', 11:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:08 INFO - 'PWD': '/builds/slave/test', 11:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:08 INFO - 'SHELL': '/bin/bash', 11:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:41:08 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:08 INFO - 'USER': 'cltbld', 11:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:08 INFO - 'XPC_FLAGS': '0x0', 11:41:08 INFO - 'XPC_SERVICE_NAME': '0', 11:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:41:08 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 11:41:08 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 11:41:08 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 11:41:08 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 11:41:08 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 11:41:08 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 11:41:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:11 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 11:41:11 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 11:41:11 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 11:41:11 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 11:41:11 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 11:41:11 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 11:41:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:12 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 11:41:12 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 11:41:12 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 11:41:12 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 11:41:12 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 11:41:12 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 11:41:13 INFO - Downloading docopt-0.6.1.tar.gz 11:41:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:13 INFO - Running setup.py install for blobuploader 11:41:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:13 INFO - Running setup.py install for requests 11:41:14 INFO - Running setup.py install for docopt 11:41:14 INFO - Successfully installed blobuploader requests docopt 11:41:14 INFO - Cleaning up... 11:41:14 INFO - Return code: 0 11:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:14 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')]} 11:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:14 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')]} 11:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:14 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:41:14 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 11:41:14 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 11:41:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:41:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:14 INFO - 'HOME': '/Users/cltbld', 11:41:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:14 INFO - 'LOGNAME': 'cltbld', 11:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:14 INFO - 'MOZ_NO_REMOTE': '1', 11:41:14 INFO - 'NO_EM_RESTART': '1', 11:41:14 INFO - 'PAGER': '/bin/cat', 11:41:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:14 INFO - 'PWD': '/builds/slave/test', 11:41:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:14 INFO - 'SHELL': '/bin/bash', 11:41:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:41:14 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:41:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:14 INFO - 'USER': 'cltbld', 11:41:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:14 INFO - 'XPC_FLAGS': '0x0', 11:41:14 INFO - 'XPC_SERVICE_NAME': '0', 11:41:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:14 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-qZscOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-CRjZKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-jIQhoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-e3Wik9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-gmyS9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-kNwOmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-rEcDWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:15 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-rgu5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-HoTxPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-oHOD6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-ND57B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-6Abxl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-oX2TtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:16 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-kzlV6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:17 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-y3_v4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:17 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-rCIvDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:17 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-0fw7kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:17 INFO - Running setup.py install for manifestparser 11:41:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:17 INFO - Running setup.py install for mozcrash 11:41:17 INFO - Running setup.py install for mozdebug 11:41:18 INFO - Running setup.py install for mozdevice 11:41:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:41:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:18 INFO - Running setup.py install for mozfile 11:41:18 INFO - Running setup.py install for mozhttpd 11:41:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:18 INFO - Running setup.py install for mozinfo 11:41:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:18 INFO - Running setup.py install for mozInstall 11:41:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Running setup.py install for mozleak 11:41:19 INFO - Running setup.py install for mozlog 11:41:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Running setup.py install for moznetwork 11:41:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:19 INFO - Running setup.py install for mozprocess 11:41:19 INFO - Running setup.py install for mozprofile 11:41:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:20 INFO - Running setup.py install for mozrunner 11:41:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:20 INFO - Running setup.py install for mozscreenshot 11:41:20 INFO - Running setup.py install for moztest 11:41:20 INFO - Running setup.py install for mozversion 11:41:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:20 INFO - Cleaning up... 11:41:21 INFO - Return code: 0 11:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:21 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')]} 11:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:21 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')]} 11:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:21 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:41:21 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 11:41:21 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 11:41:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:41:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:21 INFO - 'HOME': '/Users/cltbld', 11:41:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:21 INFO - 'LOGNAME': 'cltbld', 11:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:21 INFO - 'MOZ_NO_REMOTE': '1', 11:41:21 INFO - 'NO_EM_RESTART': '1', 11:41:21 INFO - 'PAGER': '/bin/cat', 11:41:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:21 INFO - 'PWD': '/builds/slave/test', 11:41:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:21 INFO - 'SHELL': '/bin/bash', 11:41:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:41:21 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:41:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:21 INFO - 'USER': 'cltbld', 11:41:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:21 INFO - 'XPC_FLAGS': '0x0', 11:41:21 INFO - 'XPC_SERVICE_NAME': '0', 11:41:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:21 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-m44e6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:21 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)) 11:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:21 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-qtNr64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:21 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)) 11:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:21 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-z9EglB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:21 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)) 11:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:21 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-GwkAwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:21 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)) 11:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:21 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-vteKZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-3vQNaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Ll55yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-v4DNmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-ezZjaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-UdXVOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:22 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)) 11:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:22 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-CZye4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-a5fbWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-6Q3UQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Isj6GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-jlQ1O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-SymQY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:23 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)) 11:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:23 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-N_IOQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:23 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)) 11:41:23 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)) 11:41:23 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)) 11:41:23 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)) 11:41:23 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)) 11:41:23 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)) 11:41:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:23 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 11:41:23 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 11:41:23 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 11:41:23 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 11:41:23 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 11:41:23 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 11:41:26 INFO - Downloading blessings-1.5.1.tar.gz 11:41:26 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 11:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:26 INFO - Installing collected packages: blessings 11:41:26 INFO - Running setup.py install for blessings 11:41:27 INFO - Successfully installed blessings 11:41:27 INFO - Cleaning up... 11:41:27 INFO - Return code: 0 11:41:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:27 INFO - Reading from file tmpfile_stdout 11:41:27 INFO - Current package versions: 11:41:27 INFO - blessings == 1.5.1 11:41:27 INFO - blobuploader == 1.2.4 11:41:27 INFO - docopt == 0.6.1 11:41:27 INFO - manifestparser == 1.1 11:41:27 INFO - mozInstall == 1.12 11:41:27 INFO - mozcrash == 0.16 11:41:27 INFO - mozdebug == 0.1 11:41:27 INFO - mozdevice == 0.47 11:41:27 INFO - mozfile == 1.2 11:41:27 INFO - mozhttpd == 0.7 11:41:27 INFO - mozinfo == 0.9 11:41:27 INFO - mozleak == 0.1 11:41:27 INFO - mozlog == 3.0 11:41:27 INFO - moznetwork == 0.27 11:41:27 INFO - mozprocess == 0.22 11:41:27 INFO - mozprofile == 0.27 11:41:27 INFO - mozrunner == 6.11 11:41:27 INFO - mozscreenshot == 0.1 11:41:27 INFO - mozsystemmonitor == 0.0 11:41:27 INFO - moztest == 0.7 11:41:27 INFO - mozversion == 1.4 11:41:27 INFO - psutil == 3.1.1 11:41:27 INFO - requests == 1.2.3 11:41:27 INFO - wsgiref == 0.1.2 11:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:27 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')]} 11:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:27 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')]} 11:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:27 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 0x102510490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024ed228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fd1706580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, '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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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 11:41:27 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 11:41:27 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 11:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:27 INFO - 'HOME': '/Users/cltbld', 11:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:27 INFO - 'LOGNAME': 'cltbld', 11:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:27 INFO - 'MOZ_NO_REMOTE': '1', 11:41:27 INFO - 'NO_EM_RESTART': '1', 11:41:27 INFO - 'PAGER': '/bin/cat', 11:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:27 INFO - 'PWD': '/builds/slave/test', 11:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:27 INFO - 'SHELL': '/bin/bash', 11:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:41:27 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:27 INFO - 'USER': 'cltbld', 11:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:27 INFO - 'XPC_FLAGS': '0x0', 11:41:27 INFO - 'XPC_SERVICE_NAME': '0', 11:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 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)) 11:41:28 INFO - Cleaning up... 11:41:28 INFO - Return code: 0 11:41:28 INFO - Running post-action listener: _resource_record_post_action 11:41:28 INFO - Running post-action listener: _start_resource_monitoring 11:41:28 INFO - Starting resource monitoring. 11:41:28 INFO - ##### 11:41:28 INFO - ##### Running install step. 11:41:28 INFO - ##### 11:41:28 INFO - Running pre-action listener: _resource_record_pre_action 11:41:28 INFO - Running main action method: install 11:41:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:28 INFO - Reading from file tmpfile_stdout 11:41:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:28 INFO - Reading from file tmpfile_stdout 11:41:28 INFO - Output received: 11:41:28 INFO - Usage: mozinstall [options] installer 11:41:28 INFO - Options: 11:41:28 INFO - -h, --help show this help message and exit 11:41:28 INFO - -d DEST, --destination=DEST 11:41:28 INFO - Directory to install application into. [default: 11:41:28 INFO - "/builds/slave/test"] 11:41:28 INFO - --app=APP Application being installed. [default: firefox] 11:41:28 INFO - mkdir: /builds/slave/test/build/application 11:41:28 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'] 11:41:28 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 11:42:12 INFO - Reading from file tmpfile_stdout 11:42:12 INFO - Output received: 11:42:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:42:12 INFO - Running post-action listener: _resource_record_post_action 11:42:12 INFO - ##### 11:42:12 INFO - ##### Running run-tests step. 11:42:12 INFO - ##### 11:42:12 INFO - Running pre-action listener: _resource_record_pre_action 11:42:12 INFO - Running main action method: run_tests 11:42:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:42:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:42:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:42:12 INFO - 2015-11-16 11:42:12.942 screenresolution[1631:7606] starting screenresolution argv=screenresolution get 11:42:12 INFO - 2015-11-16 11:42:12.946 screenresolution[1631:7606] Display 0: 1600x1200x32@60 11:42:12 INFO - 2015-11-16 11:42:12.953 screenresolution[1632:7608] starting screenresolution argv=screenresolution list 11:42:12 INFO - Available Modes on Display 0 11:42:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:42:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:42:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:42:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:42:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:42:13 INFO - Intel HD Graphics 3000: 11:42:13 INFO - Chipset Model: Intel HD Graphics 3000 11:42:13 INFO - Type: GPU 11:42:13 INFO - Bus: Built-In 11:42:13 INFO - VRAM (Total): 512 MB 11:42:13 INFO - VRAM (Dynamic, Max): 10 11:42:13 INFO - Vendor: Intel (0x8086) 11:42:13 INFO - Device ID: 0x0116 11:42:13 INFO - Revision ID: 0x0009 11:42:13 INFO - Displays: 11:42:13 INFO - Display: 11:42:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:42:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:42:13 INFO - Display Serial Number: 1600x1200 60 11:42:13 INFO - Main Display: Yes 11:42:13 INFO - Mirror: Off 11:42:13 INFO - Online: Yes 11:42:13 INFO - Rotation: Supported 11:42:13 INFO - Return code: 0 11:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:42:13 INFO - Python 2.7.3 11:42:13 INFO - Return code: 0 11:42:13 INFO - grabbing minidump binary from tooltool 11:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:13 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 0x1024339f0>, '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 0x102193db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024278c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:42:13 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 11:42:13 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 11:42:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:42:13 INFO - Return code: 0 11:42:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:42:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:42:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:42:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:42:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:42:13 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] in /builds/slave/test/build 11:42:13 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0033 --webServer localhost 11:42:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.reGAV4Dhwt/Render', 11:42:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:13 INFO - 'HOME': '/Users/cltbld', 11:42:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:13 INFO - 'LOGNAME': 'cltbld', 11:42:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:42:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:13 INFO - 'MOZ_NO_REMOTE': '1', 11:42:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:42:13 INFO - 'NO_EM_RESTART': '1', 11:42:13 INFO - 'PAGER': '/bin/cat', 11:42:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:13 INFO - 'PWD': '/builds/slave/test', 11:42:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:42:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:13 INFO - 'SHELL': '/bin/bash', 11:42:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yB1FPBi9fq/Listeners', 11:42:13 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 11:42:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:13 INFO - 'USER': 'cltbld', 11:42:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:13 INFO - 'XPC_FLAGS': '0x0', 11:42:13 INFO - 'XPC_SERVICE_NAME': '0', 11:42:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:42:13 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] with output_timeout 3600 11:42:13 INFO - mozversion INFO | application_buildid: 20151116095835 11:42:13 INFO - mozversion INFO | application_changeset: 647f70a15615ce77b1eb74bd73df36a35576bc93 11:42:13 INFO - mozversion INFO | application_display_name: Nightly 11:42:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:42:13 INFO - mozversion INFO | application_name: Firefox 11:42:13 INFO - mozversion INFO | application_remotingname: firefox 11:42:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:42:13 INFO - mozversion INFO | application_vendor: Mozilla 11:42:13 INFO - mozversion INFO | application_version: 45.0a1 11:42:13 INFO - mozversion INFO | platform_buildid: 20151116095835 11:42:13 INFO - mozversion INFO | platform_changeset: 647f70a15615ce77b1eb74bd73df36a35576bc93 11:42:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:42:13 INFO - mozversion INFO | platform_version: 45.0a1 11:42:13 INFO - 2015-11-16 11:42:13,742 DEBUG : using testdate: 1447702933 11:42:13 INFO - 2015-11-16 11:42:13,742 DEBUG : actual date: 1447702933 11:42:13 INFO - 2015-11-16 11:42:13,752 INFO : starting webserver on 'localhost:49268' 11:42:13 INFO - 2015-11-16 11:42:13,753 INFO : Starting test suite t-yosemite-r5-0033 11:42:13 INFO - 2015-11-16 11:42:13,753 INFO : Starting test dromaeo_css 11:42:13 INFO - 2015-11-16 11:42:13,754 DEBUG : operating with platform_type : mac_ 11:42:13 INFO - 2015-11-16 11:42:13,755 INFO : Initialising browser for dromaeo_css test... 11:42:13 INFO - 2015-11-16 11:42:13,787 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpaXLYEX/profile http://localhost:49268/getInfo.html 11:42:17 INFO - 2015-11-16 11:42:17,669 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:17 INFO - 2015-11-16 11:42:17,670 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:17 INFO - 2015-11-16 11:42:17,670 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:42:17 INFO - 2015-11-16 11:42:17,670 DEBUG : BROWSER_OUTPUT: __metrics 11:42:17 INFO - 2015-11-16 11:42:17,690 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:18 INFO - 2015-11-16 11:42:18,483 INFO : Browser initialized. 11:42:18 INFO - 2015-11-16 11:42:18,483 INFO : Running cycle 1/1 for dromaeo_css test... 11:42:18 INFO - 2015-11-16 11:42:18,483 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpaXLYEX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:42:30 INFO - 2015-11-16 11:42:30,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 228839424 11:42:30 INFO - 2015-11-16 11:42:30,745 DEBUG : BROWSER_OUTPUT: 11:43:22 INFO - 2015-11-16 11:43:22,642 DEBUG : BROWSER_OUTPUT: 1447703002639 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] 11:45:32 INFO - 2015-11-16 11:45:32,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 11:45:34 INFO - 2015-11-16 11:45:34,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 351784960 11:45:34 INFO - 2015-11-16 11:45:34,083 DEBUG : BROWSER_OUTPUT: 11:48:37 INFO - 2015-11-16 11:48:37,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 11:48:37 INFO - 2015-11-16 11:48:37,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 363589632 11:48:37 INFO - 2015-11-16 11:48:37,822 DEBUG : BROWSER_OUTPUT: 11:51:40 INFO - 2015-11-16 11:51:40,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 11:51:40 INFO - 2015-11-16 11:51:40,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 320647168 11:51:40 INFO - 2015-11-16 11:51:40,924 DEBUG : BROWSER_OUTPUT: 11:54:43 INFO - 2015-11-16 11:54:43,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 11:54:43 INFO - 2015-11-16 11:54:43,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 315797504 11:54:43 INFO - 2015-11-16 11:54:43,761 DEBUG : BROWSER_OUTPUT: 11:57:47 INFO - 2015-11-16 11:57:47,103 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 11:57:47 INFO - 2015-11-16 11:57:47,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 318562304 11:57:47 INFO - 2015-11-16 11:57:47,692 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 12:00:50 INFO - 2015-11-16 12:00:50,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 366448640 12:00:50 INFO - 2015-11-16 12:00:50,815 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,816 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:00:50 INFO - 2015-11-16 12:00:50,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:00:50 INFO - 2015-11-16 12:00:50,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:00:50 INFO - 2015-11-16 12:00:50,816 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:00:50 INFO - 2015-11-16 12:00:50,820 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2521.1806162997027;2545.249151500308;2579.8323108997924;2585.7284985076567;2588.184721812629;4024.818883150258;4166.770827604484;4173.624373806357;4181.60274773896;4315.395844581753;4247.150569886027;4293.914121717572;4294.033842385462;4346.934795978055;4394.824207031715;3671.477602312399;3838.7888666123354;3851.7496362736333;3941.467901833259;3995.6603688686496;3935.4687117239237;3943.7042221833335;3992.6606238469767;4055.6755459563165;4094.8566800162002;3813.9427908581392;3850.1144736710435;3877.3990031545154;3956.030772460737;3984.5816189300285;3892.5912779158066;3939.468171796799;4001.1197536542204;4002.5597184309704;4041.3937909313545;3932.6067393260732;3939.862104826346;3953.051267695761;4037.899052523681;4058.817353219112;4126.649234815014;4159.022629682022;4166.979165104185;4215.494140703136;4265.232258193524;4475.060237350161;4541;4602.401687780567;4618.237990731525;4668.929966050512;4551.8179272829375;4586.931196032062;4603.261059669491;4673.556012178838;4677.228257337535;3885.8251378687746;4175.457190565207;4177.101923086551;4243.172581346669;4312.935305970413;4588.449386073693;4589.770511474413;4629.907401851944;4713.67004309695;4717.174494463455;4317.913641727211;4410.33844923264;4423.623991960655;4443.33349997503;4513.593776560059;4556.066006468666;4587.853036740815;4600.884977875513;4619.5611416915335;4652.813887444464;4481.3726078349055;4482.618977386894;4544.840930567414;4583.014651849869;4649.976750116295;4369.6722745794195;4375.234333991602;4476.239039363316;4494.595486406239;4543.477500087466;3479.408500554912;3499.772514786531;3536.6463353664426;3541.645835416438;3577.5170352002147;3180.840957952093;3233.547303377529;3234.4016356974034;3244.8053116813066;3262.1029216965526;4130.194612050681;4174.603412675791;4275.230458517497;4313.503947046067;4330.935035974463;4582.770861456914;4635.814567417333;4656.045510670305;4699.577038066522;4761;4322.24360736876;4325.178216138924;4371;4386.495553011381;4434.246178149722;3904.1996390740396;3970.463987361727;4013.5986401360215;4047.210793895162;4098.6516146127315;4700.106979673851;4752.382190315237;4756.429228492603;4766.809327626995;4786.497417771084;4606.700564463299;4606.746628935441;4628.861134165981;4686.953130468652;4735.573798358164;4532.841350552715;4604.102200070954;4687.601553867959;4695.366125573004;4745.5966242869745;4537.478190008192;4549.249373853409;4587.72473651582;4618.46887607916;4640.698354607075;4578.954210457853;4586.793594288199;4644.535546445463;4659.743714095757;4684.953150468588;4198.664106871504;4401.911961760811;4467.553244675506;4481.686281960231;4602;4431.224535706303;4531.093781243699;4569.748663823389;4572.565606267399;4586.931196032129;4343.956560434355;4389.275769497997;4406.889827754332;4461.531539188469;4488.64090872736;4427.490838553479;4432.889177770581;4455.220336441174;4461.598456138963;4557.293619488984;4471.977640111779;4472.753998530112;4499.955000450084;4505.324201369821;4509.842155524672 12:00:50 INFO - 2015-11-16 12:00:50,821 DEBUG : BROWSER_OUTPUT: |1;ext.html;444.22704494180124;447.8119189940225;450.5967159392344;451.75830930452213;478.97021403981455;25437.618435723456;25477.74522254777;25907.352316192104;25988.480230395406;31519.527207091855;33138.17154571137;33565.32869342612;33826.49260261098;34554.654453455456;34648;7142.642867856599;7289.489735718502;7292.015577896996;7316.122065352165;7438.181800001996;6764.6617669116595;6799.52403331767;6822.897656535156;7050.929490705079;7241.058662373884;8966.462012279284;9027.729168124933;9053.547322633842;9118.17936385725;9185.219256363218;8806;8879.11208879107;8910.886139232596;9022.5939832708;9028.232600228988;6542.869142617121;6852.725890964355;6869.587824730482;8718.346124040723;8854.804601378795;31700.841495792603;31786;31859.362812743846;32142.196445088826;32537;2294.701688780448;2315.340128063494;2449.216250799745;2451.350392146083;2496.0390249753796;22109.778902211092;22161.224357147585;22376.776232237633;22686.092556297728;22916.541669166523;1854.75888134543;1861.5997560524552;1884.9717254241198;1950.0834607734341;1983.771866235387;220145;220390;224911;225423;226429;45297.547024529995;46003;46545;48223.75888120537;48788;56361;57009.714951424976;57161.42838571644;57882.42117578854;57921.71039144777;11733.061355091571;11847.466863991142;11890.88109118915;11970.700732481757;12115;8705.173008564303;8816.75172830924;8919.910800892038;8954.552272386354;9073.909260907307;15864.206789660471;16091.597710057342;16152.434664786677;16263.674726505404;16311.42909998168;6632.137822083098;6800.727970881109;6822.079019332326;6955.8956615649795;6960.129983752031;722.3895808042196;746.4588173574224;773.9458237923292;775.9379249660013;782.1591788827034;22719.88640056789;23394;23498.177563785528;23821;23822.88088559546;823.4853216739538;825.1336097098143;826.1738261738262;838.1995194589275;854.3037424499014;10737.946310268399;10757.193210509244;10915;11059.281146725438;11313.377764222882;238082;241648;245392;246127;246204;42652.09500907436;42983.35524967128;43034.56965430368;44071.55928440738;44127.33808992868;1020.0768304684125;1060.1995493402433;1077.1436707817304;1081.9459027048774;1082.1451053667515;20344.287949921683;20742.274020409815;20822.58354832925;20844.47888802792;20909.686354704994;38454;38758.80620596879;38759.03102422349;38871.6112838868;39375.40936885892;217589;221218;226510;226703;227011;21247.78752212458;21864;22217.888910555343;22403.775962240168;23761;25937.740622594287;28300;29432.705672942997;30170.84914575413;32437.026889193363;26231.081912132984;26393;26544.469110618065;26562.86718566395;26739.33151671224;25839.741602583734;25854.87072564625;26113.347166320993;26293.4741305169;26477.735222647527;23950.28149155528;24181.51636967286;24457.75542244626;28033.43933121367;28079.43841123125;22680.319590412313;23900.760992389853;24580.877095614407;24816.751832481445;25024.499510009333;18158.90920545389;18522.722159167355;18532.722009170142;18782.342618008304;18819.341323053628 12:00:50 INFO - 2015-11-16 12:00:50,825 DEBUG : BROWSER_OUTPUT: |2;jquery.html;265.5101338031332;267.5184667598325;267.5371607119683;272.1427503364401;273.68389510115816;10638.893611063888;10985.61550345738;13159.473621055158;13784.241866697328;13790.103643263194;11416.486258118384;13680.589582312547;13771.724565508684;13794.10338328008;14818.777718334233;4267.4025636410925;4347.087111706545;4361.062371590107;4385.956140438602;4454.33185022246;3103.829289389094;3184.3153721949775;4342.717723347972;4384.714993525411;4558.612517935962;4552.08958208358;4581.885452863672;4653.790579423934;4690;4755.239161734124;4605.078984203139;4635.513271106519;4694.037722266927;4710.646701497367;4722.38608980832;4008.8596899108684;4061.1268577256033;4080.6531444827224;4102.856400025985;4110.958890411118;16769.580760480963;16851.494455166365;16935.491935241964;17054.488365349058;17092.82907170925;1661.808891977426;1692.813790483046;1702.6424450865209;1741.6777896089263;1831.8809277396927;10671.626493072783;10679.252452328341;10808.891911080946;10841.67474975752;10868.239223254375;1271.1800888426912;1311.1282629776938;1328.3491089366141;1345.9730805383936;1356.7422189783908;44916.10167796659;44972;45847.54152458466;47334.76332618349;48286;7194.568325900463;7442.702291908371;7519.73680921176;7611.65747541362;7662.923370766221;9233.399829011092;9279.304052195977;9344.785177926962;9371.953140234255;9415.199708024895;5454.754536045808;5628.380878103405;5704.372519022904;5717.399673034354;5746.367899531048;5461.726913654381;5501.944980550224;5525.751341189656;5531.142672885629;5558.416366281563;4470.619997300266;4489.506154323022;4532.909341813145;4591.79336929839;4600.171969045537;1234.672811704899;1312.5078095714107;1312.9409176587076;1323.1465704620466;1343.5566263133142;299.77666638354566;327.675601154855;340.8125530957963;673.3973094080868;734.3207533032031;8210.137935516805;8370.916290837136;8855.291576673852;9150.81698366029;9643.517824108907;351.75680228295585;352.1934769378095;352.2813460540469;359.7985128328145;362.55043745755603;4306.2894622387585;5102.08162530748;5106.259592359087;5162.793488260502;5199.896002079937;458344;459783;464606;476311;481668;55388.723056385264;56465.43534564684;57287.71356143193;58164.70917645469;58257;385.9363205071188;387.2603327644242;389.4742098167508;392.7839688171494;396.78771857056336;8450.366222533457;8531.274841638531;8556.871646925425;8723.651053958025;8828.025794885738;25954.48091038131;26550;26828.731712682624;27640.585391218745;27671.169864904085;34657.826710866284;34904.65095349014;35050.298994020486;35530.46704299489;35596.28807423889;4670.5329467053025;4988.725620090785;5027.824026159067;5033.345665063518;5067.011932673094;9218.26253899673;9369.85945210836;9516.095970882756;9570.56932438028;9660.32377733552;6692.364225398579;6963.338482844122;7061.470389720895;8064.637091331021;8119.106898241071;7635.961820190863;7808.141104478616;7838.294553490213;7883.526988380716;7909.683612655429;6887.276835932155;7845.176256493214;8131.674733010614;8184.099749027483;8390.874136887829;4374.475062992461;4442.600165985077;4748.287756836502;4861.878453038561;4981.900361992813;7344.669489873076;7762.146163922077;7967.521948683097;8027.076886158166;8085.070216925129 12:00:50 INFO - 2015-11-16 12:00:50,825 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1255.9686007849798;1326.1102928327132;1402.698419839735;1431.8424973252947;1446.3202294921387;5463.672179669223;6070.484008859252;6095.817125486232;6334.398232167948;6345.428911397973;5772.826815195541;5841.707914604274;5865.530757539397;5915.940840591604;6004.189434426351;1798.6043070524463;1843.8709290349682;1846;1851.0837135617887;1875.3155098389127;1785.5446861050414;1810.248746770089;1814.1020195003425;1822.7630408046934;1853.3791179954665;1823.2524664887399;1823.6626224148574;1854.4622059602766;1875.746774185488;1876.6059127583223;1718.8109307976113;1730.108993868159;1760.559860034985;1775.0237369446752;1799.8119599444842;1737.444017914268;1757.77148970633;1773.4413659697154;1775.6981313176661;1807.6565452564103;5501.477359650827;6096.878062438726;6255;6271.153394291758;6328.335524769925;3491.528643633128;3689.262147570497;3757.699384049297;3809.1619843634357;3900.0054985978677;2316.200910685811;2411.0958390603523;2436.792872605831;2452.3746444656676;2472.418981539337;680.0513283968885;683.835879388948;710.0627172132787;724.8296650287178;757;8386.203310685476;8398.118197589287;8491.915080849174;8507.659693612248;8572.057073721886;3565.5008298838184;3705.777653340754;3734.495843061152;3739.1586892949413;3758.680512156497;7406.444516661272;7476.626168691544;7482.176960534337;7486.850262994819;7600.315971562586;4046.7571945683353;4092.7544347339253;4100.323446631272;4138.896527586834;4146.253674338648;3666.7983260920373;3674.41209406499;3678.4666223397458;3702.3705969985167;3714.814259287025;2882.6829048804616;2942.14677743452;2950.601668774731;2981.6123903892353;2984.7612191024664;923.6397804856111;955.5317894231915;957.3872721458272;967.0764419978904;973.3744646440462;1019.6023550815188;1037.7457522906936;1041.1774697988656;1054.9103326217357;1063.7659714862718;5919.526437885045;5947.1376650385455;6084.756609735649;6097.542684298695;6097.664628445478;376.1705439505883;377.8507489541616;946.8769060022291;963.3593660216018;1003.5433877585681;4675.368825208621;4736.810527578928;4755.785989630475;4770.809167633256;4781.187198176319;6484.319146489645;6539.836504087436;6793.082933803972;7302.525335853153;7726.961365193138;7404.518706284182;7488;7488.138864030598;7561.962190189124;7636.007319048599;5596;5631.605787594911;5660.801871934463;5730.713464326767;5809;5647.604667673223;5674.375818660027;5706.857328566819;5763.193152958505;5787.39232380594;6156.107364432043;6195.907061393992;6257.249130104235;6278.183836101278;6291.087792270004;6358.205224346957;6459.192600924885;6461.160049193575;6519.8044058678315;6618.1065556151225;5627.409122042127;5709.8287051388525;5728.283964504437;5757.510611598061;5807.041838096667;6108.08378743192;6164.291106522807;6167.383261673796;6203.410675985955;6213.502919766317;5487.725613719218;5689.089745640677;5721.370649228498;5750.971245143747;5788.450097240755;5553.250311208097;5615.915761263503;5667.801626943202;5702;5798.391168927371;5526.115821468546;5670.8015219467125;5682.261306030189;5710.400407957105;5788.652680839163;5210.296609957607;5227.2420499028185;5239.266502689703;5277.155655095166;5287.947120528899;4816.373871396696;5241.6068794839775;5303.231031500333;5318.946810531846;5377.516023557742 12:00:50 INFO - 2015-11-16 12:00:50,829 DEBUG : BROWSER_OUTPUT: |4;prototype.html;242.76330577686755;252.29232004228137;253.15067947037687;253.79062273624243;260.7952757085688;4986.75066246688;5060.848174554764;5081.542661160494;5104.438511763703;5150.562202212816;4815.759212039402;4841.491643377448;4897.020595880829;4928.605711543077;5015.9749201254035;3734.495843061179;3802.163524024717;3807.1053302474033;3837.4052021936504;3846.1730727893496;3810.8094595270263;3830.291396091718;3871.857801948418;3887.611238876118;3906.5507466641275;3640.981795091034;3690.4464330350393;3759.3609086455367;3803.0302272920503;3822.617738226169;3736.271427071722;3767.05823544114;3781.5651200111924;3847.8460861565645;3864.2851072551666;3266.183454136466;3274.4269752793166;3309.635940046593;3309.635940046617;3310.4372256716415;4718.457377401608;4851.708897466128;4852.539008794159;4866.7566621668775;4971.105201063807;4063;4283.700140990132;4304.311310190355;4324.632406245473;4334.154839806239;5207.921881171786;5210.088234558937;5245.554127899133;5278.498542638482;5318.388385335697;3413.9829300853335;3429.8456569454183;3470.3059388122224;3482.9303413931834;3510.3856825055514;5476.507114359727;5487.533559647435;5560.694161821139;5565.805196818092;5610.579206559483;3502.4746288056485;3524.0308915048054;3548.769329993542;3552.786832790041;3567.8572857085946;3463.5497385339745;3590.24604832988;3594.4428613564937;3638.235970446183;3647.963520364762;4187.644050255702;4231.174920890397;4232.0054787125;4270.402143699885;4282.421873047161;5287.762050707727;5292.682439053669;5342.225377320345;5383.093129709991;5396.217548455452;1247.8377810884526;1256.2399748152418;1261.9432125554372;1288.1498211180576;1289.9871001289866;793.714262865368;813.0690359538296;817.9263866252065;820.2576668115365;821.6836517940517;5021.322121513549;5064.240363945438;5103;5106;5147.974260128675;5450.509454149066;5499.450054994469;5563.666180029211;5574.470425309589;5622.0161471742285;4911.778969946361;5003.424606170264;5041.8487445376695;5121.206213036985;5145.639805213599;2914.3151359430517;2914.6502419709773;2941.97058029417;2963.155500682295;3009.3830764693184;5646.378898321182;5660.235868157828;5689.288838895138;5722.942770572325;5800.071988481823;5652.858678532987;5688.146777983253;5688.573356998241;5710.428957104256;5763.337216220105;5587.720613969285;5697.4302569742695;5744.080947048536;5764.654120752768;5824.359320474659;5533.059379905345;5564.666120032811;5571.60998730085;5640.351359593699;5671.120976248688;5439.864003399946;5461.590380721541;5462;5561.527270181918;5583.441655834384;5561.5272701820795;5724.141378793214;5738.8278351649515;5772.740226689725;5852.5317974561085;3561.0207193021092;3571.749977501654;3592.2276710507367;3618.3848745712767;3630.3102410541915;5520.254765606592;5546.306711661043;5582.720863956704;5621.213030175697;5658.405867383865;5419.756110974937;5438.728063596884;5449.536789372948;5469.535089517435;5473.096939005179;5262.657927234717;5403.675779453245;5445.2104444854485;5517.255170552085;5545.528630066328;5280.841574752763;5288.9735551322;5407.972960135174;5417.322834645669;5435.641089727568;5406.405295417422;5445.1832225166545;5454.972725136349;5533.695646739468;5537.723113844372;5101.897962040813;5288.206768984683;5298.894022119459;5425.294711687456;5461.371942226695 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: |5;yui.html;537.623663435595;568.5224411494344;590.6279044202151;603.4585097542638;623.557274335222;10775.83836242456;11172.720681982955;11234;11299.152563557725;11330.433478326082;10193.184545236381;10275.12661423778;10527.15782737381;10536.894631053687;10739;570.7403131575144;571.0378013048006;574.2792795042216;714.1537278325176;717.1573401253519;697.1077021412575;715.2882881532882;724.3119036914926;725.6408078001397;736.9410447164241;737.2369597466624;737.3842841227581;742.6286856571714;744.3449764207517;750.9474336796427;577.0882006429852;591.914172444993;595.0479233226846;711.3171355498675;732.1397358104233;540.0872525432046;542.4765101676861;545.8498912798972;549.3270743339417;554.7115499940049;10946.233763636548;10972.396518191495;11000.394978276192;11101.611443599435;11169.609063682732;9079.909200908038;9250.259979201648;9374;9656.95171524138;9710.854337184948;7406.333429991327;7473;7547.320741133324;7652.2347765223585;7798.883016754753;2588.8058395620405;2622.93442663933;2665.5468570342896;2690.825096368749;2767.9758489358865;38378.232435351136;38756.41865372022;38968;39190;39834.800825995684;7128.6435678215885;7170.749023784247;7198.820029499305;7206.603636800026;7285.052943117361;15237.238138093051;15261.6184595386;15285.465008724863;15446;15463.690726185638;5720.427957204246;5762.4525670061275;5819.185314056035;5933.673647949404;6008.309044459856;3015.1557563882147;3114.7352475039875;3126.1403114143336;3207.5990501187352;3207.6150861896253;2366.9053237870635;2378.2865140457793;2386.1648423051793;2404.9038038478616;2448.192096608115;348.3503266408131;412.2888018168635;417.5156818091;442.9723042541273;443.4456928838951;442.54638995030353;448.4887228559445;452.1431886574922;480.4210925834361;490.53644306130366;5586.748596313176;6016.819495415057;6127.172831667757;6293.527985401113;6333.081703153109;445.1297712971134;445.6635240393482;469.3640117640548;480.81488626878206;498.2501335490064;2944.425836961772;2981.910542683723;3028.1067085209916;3136.6706495818066;3136.780425370248;43503;43535.34696979548;44704;44762.77618611951;44836.3274550882;39491.2101757969;40459.79770101131;40531.189376212904;40622.39066414006;40935.38596920989;36231.4565281521;37587;37657.246855062745;38138.61861381406;38653;6163.35284795108;6593.241777195684;6593.406593406617;6664.4668426524795;6752.628605426748;25890.22329330123;26309.736902630728;26476.338091547866;28370.57444138298;29342;35444.46833297554;35518.46722299116;36149.09627259339;36981.81509092437;37001.51993920213;5818.883622327615;5848;5873.353931067664;6131.080337949344;6250.812475625738;8635.136486351315;8653.264472519906;8885.777855553662;8945.955270223607;8955.820883582162;8063.435559510778;8213.876791848008;8258.710945116893;8462.619182136696;8467.49195048299;8280.213379728915;8360.289375402916;8452.36607254446;8455.492670439793;8464.492130472192;7707.845843083219;7765.844683106419;7820.765377038698;7897.368210543258;8396.328293736364;6799.694013769491;6997.580145191305;7466.104067511933;7539.472236943361;7549.282818132268;7269.284719434059;7284.125904891235;7389.224131466119;7541.283578060075;7662 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1117 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:00:50 INFO - 2015-11-16 12:00:50,832 DEBUG : BROWSER_OUTPUT: __startTimestamp1447704050815__endTimestamp 12:00:50 INFO - 2015-11-16 12:00:50,833 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,833 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:00:50 INFO - 2015-11-16 12:00:50,833 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:00:50 INFO - 2015-11-16 12:00:50,833 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,833 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4262.35 Median:4410.34 stddev:464.13 (10.5%) stddev-sans-first:445.00 12:00:50 INFO - 2015-11-16 12:00:50,834 DEBUG : BROWSER_OUTPUT: Values: 2521.2 2545.2 2579.8 2585.7 2588.2 4024.8 4166.8 4173.6 4181.6 4315.4 4247.2 4293.9 4294.0 4346.9 4394.8 3671.5 3838.8 3851.7 3941.5 3995.7 3935.5 3943.7 3992.7 4055.7 4094.9 3813.9 3850.1 3877.4 3956.0 3984.6 3892.6 3939.5 4001.1 4002.6 4041.4 3932.6 3939.9 3953.1 4037.9 4058.8 4126.6 4159.0 4167.0 4215.5 4265.2 4475.1 4541.0 4602.4 4618.2 4668.9 4551.8 4586.9 4603.3 4673.6 4677.2 3885.8 4175.5 4177.1 4243.2 4312.9 4588.4 4589.8 4629.9 4713.7 4717.2 4317.9 4410.3 4423.6 4443.3 4513.6 4556.1 4587.9 4600.9 4619.6 4652.8 4481.4 4482.6 4544.8 4583.0 4650.0 4369.7 4375.2 4476.2 4494.6 4543.5 3479.4 3499.8 3536.6 3541.6 3577.5 3180.8 3233.5 3234.4 3244.8 3262.1 4130.2 4174.6 4275.2 4313.5 4330.9 4582.8 4635.8 4656.0 4699.6 4761.0 4322.2 4325.2 4371.0 4386.5 4434.2 3904.2 3970.5 4013.6 4047.2 4098.7 4700.1 4752.4 4756.4 4766.8 4786.5 4606.7 4606.7 4628.9 4687.0 4735.6 4532.8 4604.1 4687.6 4695.4 4745.6 4537.5 4549.2 4587.7 4618.5 4640.7 4579.0 4586.8 4644.5 4659.7 4685.0 4198.7 4401.9 4467.6 4481.7 4602.0 4431.2 4531.1 4569.7 4572.6 4586.9 4344.0 4389.3 4406.9 4461.5 4488.6 4427.5 4432.9 4455.2 4461.6 4557.3 4472.0 4472.8 4500.0 4505.3 4509.8 12:00:50 INFO - 2015-11-16 12:00:50,834 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,834 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36424.61 Median:26553.67 stddev:60299.08 (227.1%) stddev-sans-first:60407.72 12:00:50 INFO - 2015-11-16 12:00:50,835 DEBUG : BROWSER_OUTPUT: Values: 444.2 447.8 450.6 451.8 479.0 25437.6 25477.7 25907.4 25988.5 31519.5 33138.2 33565.3 33826.5 34554.7 34648.0 7142.6 7289.5 7292.0 7316.1 7438.2 6764.7 6799.5 6822.9 7050.9 7241.1 8966.5 9027.7 9053.5 9118.2 9185.2 8806.0 8879.1 8910.9 9022.6 9028.2 6542.9 6852.7 6869.6 8718.3 8854.8 31700.8 31786.0 31859.4 32142.2 32537.0 2294.7 2315.3 2449.2 2451.4 2496.0 22109.8 22161.2 22376.8 22686.1 22916.5 1854.8 1861.6 1885.0 1950.1 1983.8 220145.0 220390.0 224911.0 225423.0 226429.0 45297.5 46003.0 46545.0 48223.8 48788.0 56361.0 57009.7 57161.4 57882.4 57921.7 11733.1 11847.5 11890.9 11970.7 12115.0 8705.2 8816.8 8919.9 8954.6 9073.9 15864.2 16091.6 16152.4 16263.7 16311.4 6632.1 6800.7 6822.1 6955.9 6960.1 722.4 746.5 773.9 775.9 782.2 22719.9 23394.0 23498.2 23821.0 23822.9 823.5 825.1 826.2 838.2 854.3 10737.9 10757.2 10915.0 11059.3 11313.4 238082.0 241648.0 245392.0 246127.0 246204.0 42652.1 42983.4 43034.6 44071.6 44127.3 1020.1 1060.2 1077.1 1081.9 1082.1 20344.3 20742.3 20822.6 20844.5 20909.7 38454.0 38758.8 38759.0 38871.6 39375.4 217589.0 221218.0 226510.0 226703.0 227011.0 21247.8 21864.0 22217.9 22403.8 23761.0 25937.7 28300.0 29432.7 30170.8 32437.0 26231.1 26393.0 26544.5 26562.9 26739.3 25839.7 25854.9 26113.3 26293.5 26477.7 23950.3 24181.5 24457.8 28033.4 28079.4 22680.3 23900.8 24580.9 24816.8 25024.5 18158.9 18522.7 18532.7 18782.3 18819.3 12:00:50 INFO - 2015-11-16 12:00:50,835 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,836 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22771.85 Median:232187.40 stddev:76510.39 (33.0%) stddev-sans-first:76706.35 12:00:50 INFO - 2015-11-16 12:00:50,837 DEBUG : BROWSER_OUTPUT: Values: 265.5 267.5 267.5 272.1 273.7 10638.9 10985.6 13159.5 13784.2 13790.1 11416.5 13680.6 13771.7 13794.1 14818.8 4267.4 4347.1 4361.1 4386.0 4454.3 3103.8 3184.3 4342.7 4384.7 4558.6 4552.1 4581.9 4653.8 4690.0 4755.2 4605.1 4635.5 4694.0 4710.6 4722.4 4008.9 4061.1 4080.7 4102.9 4111.0 16769.6 16851.5 16935.5 17054.5 17092.8 1661.8 1692.8 1702.6 1741.7 1831.9 10671.6 10679.3 10808.9 10841.7 10868.2 1271.2 1311.1 1328.3 1346.0 1356.7 44916.1 44972.0 45847.5 47334.8 48286.0 7194.6 7442.7 7519.7 7611.7 7662.9 9233.4 9279.3 9344.8 9372.0 9415.2 5454.8 5628.4 5704.4 5717.4 5746.4 5461.7 5501.9 5525.8 5531.1 5558.4 4470.6 4489.5 4532.9 4591.8 4600.2 1234.7 1312.5 1312.9 1323.1 1343.6 299.8 327.7 340.8 673.4 734.3 8210.1 8370.9 8855.3 9150.8 9643.5 351.8 352.2 352.3 359.8 362.6 4306.3 5102.1 5106.3 5162.8 5199.9 458344.0 459783.0 464606.0 476311.0 481668.0 55388.7 56465.4 57287.7 58164.7 58257.0 385.9 387.3 389.5 392.8 396.8 8450.4 8531.3 8556.9 8723.7 8828.0 25954.5 26550.0 26828.7 27640.6 27671.2 34657.8 34904.7 35050.3 35530.5 35596.3 4670.5 4988.7 5027.8 5033.3 5067.0 9218.3 9369.9 9516.1 9570.6 9660.3 6692.4 6963.3 7061.5 8064.6 8119.1 7636.0 7808.1 7838.3 7883.5 7909.7 6887.3 7845.2 8131.7 8184.1 8390.9 4374.5 4442.6 4748.3 4861.9 4981.9 7344.7 7762.1 7967.5 8027.1 8085.1 12:00:50 INFO - 2015-11-16 12:00:50,837 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,837 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4366.78 Median:5629.51 stddev:2219.96 (39.4%) stddev-sans-first:2213.88 12:00:50 INFO - 2015-11-16 12:00:50,839 DEBUG : BROWSER_OUTPUT: Values: 1256.0 1326.1 1402.7 1431.8 1446.3 5463.7 6070.5 6095.8 6334.4 6345.4 5772.8 5841.7 5865.5 5915.9 6004.2 1798.6 1843.9 1846.0 1851.1 1875.3 1785.5 1810.2 1814.1 1822.8 1853.4 1823.3 1823.7 1854.5 1875.7 1876.6 1718.8 1730.1 1760.6 1775.0 1799.8 1737.4 1757.8 1773.4 1775.7 1807.7 5501.5 6096.9 6255.0 6271.2 6328.3 3491.5 3689.3 3757.7 3809.2 3900.0 2316.2 2411.1 2436.8 2452.4 2472.4 680.1 683.8 710.1 724.8 757.0 8386.2 8398.1 8491.9 8507.7 8572.1 3565.5 3705.8 3734.5 3739.2 3758.7 7406.4 7476.6 7482.2 7486.9 7600.3 4046.8 4092.8 4100.3 4138.9 4146.3 3666.8 3674.4 3678.5 3702.4 3714.8 2882.7 2942.1 2950.6 2981.6 2984.8 923.6 955.5 957.4 967.1 973.4 1019.6 1037.7 1041.2 1054.9 1063.8 5919.5 5947.1 6084.8 6097.5 6097.7 376.2 377.9 946.9 963.4 1003.5 4675.4 4736.8 4755.8 4770.8 4781.2 6484.3 6539.8 6793.1 7302.5 7727.0 7404.5 7488.0 7488.1 7562.0 7636.0 5596.0 5631.6 5660.8 5730.7 5809.0 5647.6 5674.4 5706.9 5763.2 5787.4 6156.1 6195.9 6257.2 6278.2 6291.1 6358.2 6459.2 6461.2 6519.8 6618.1 5627.4 5709.8 5728.3 5757.5 5807.0 6108.1 6164.3 6167.4 6203.4 6213.5 5487.7 5689.1 5721.4 5751.0 5788.5 5553.3 5615.9 5667.8 5702.0 5798.4 5526.1 5670.8 5682.3 5710.4 5788.7 5210.3 5227.2 5239.3 5277.2 5287.9 4816.4 5241.6 5303.2 5318.9 5377.5 12:00:50 INFO - 2015-11-16 12:00:50,839 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,840 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4435.90 Median:5105.22 stddev:1396.03 (27.3%) stddev-sans-first:1364.01 12:00:50 INFO - 2015-11-16 12:00:50,840 DEBUG : BROWSER_OUTPUT: Values: 242.8 252.3 253.2 253.8 260.8 4986.8 5060.8 5081.5 5104.4 5150.6 4815.8 4841.5 4897.0 4928.6 5016.0 3734.5 3802.2 3807.1 3837.4 3846.2 3810.8 3830.3 3871.9 3887.6 3906.6 3641.0 3690.4 3759.4 3803.0 3822.6 3736.3 3767.1 3781.6 3847.8 3864.3 3266.2 3274.4 3309.6 3309.6 3310.4 4718.5 4851.7 4852.5 4866.8 4971.1 4063.0 4283.7 4304.3 4324.6 4334.2 5207.9 5210.1 5245.6 5278.5 5318.4 3414.0 3429.8 3470.3 3482.9 3510.4 5476.5 5487.5 5560.7 5565.8 5610.6 3502.5 3524.0 3548.8 3552.8 3567.9 3463.5 3590.2 3594.4 3638.2 3648.0 4187.6 4231.2 4232.0 4270.4 4282.4 5287.8 5292.7 5342.2 5383.1 5396.2 1247.8 1256.2 1261.9 1288.1 1290.0 793.7 813.1 817.9 820.3 821.7 5021.3 5064.2 5103.0 5106.0 5148.0 5450.5 5499.5 5563.7 5574.5 5622.0 4911.8 5003.4 5041.8 5121.2 5145.6 2914.3 2914.7 2942.0 2963.2 3009.4 5646.4 5660.2 5689.3 5722.9 5800.1 5652.9 5688.1 5688.6 5710.4 5763.3 5587.7 5697.4 5744.1 5764.7 5824.4 5533.1 5564.7 5571.6 5640.4 5671.1 5439.9 5461.6 5462.0 5561.5 5583.4 5561.5 5724.1 5738.8 5772.7 5852.5 3561.0 3571.7 3592.2 3618.4 3630.3 5520.3 5546.3 5582.7 5621.2 5658.4 5419.8 5438.7 5449.5 5469.5 5473.1 5262.7 5403.7 5445.2 5517.3 5545.5 5280.8 5289.0 5408.0 5417.3 5435.6 5406.4 5445.2 5455.0 5533.7 5537.7 5101.9 5288.2 5298.9 5425.3 5461.4 12:00:50 INFO - 2015-11-16 12:00:50,840 DEBUG : BROWSER_OUTPUT: 12:00:50 INFO - 2015-11-16 12:00:50,840 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10724.22 Median:3070.73 stddev:12744.54 (415.0%) stddev-sans-first:12757.33 12:00:50 INFO - 2015-11-16 12:00:50,842 DEBUG : BROWSER_OUTPUT: Values: 537.6 568.5 590.6 603.5 623.6 10775.8 11172.7 11234.0 11299.2 11330.4 10193.2 10275.1 10527.2 10536.9 10739.0 570.7 571.0 574.3 714.2 717.2 697.1 715.3 724.3 725.6 736.9 737.2 737.4 742.6 744.3 750.9 577.1 591.9 595.0 711.3 732.1 540.1 542.5 545.8 549.3 554.7 10946.2 10972.4 11000.4 11101.6 11169.6 9079.9 9250.3 9374.0 9657.0 9710.9 7406.3 7473.0 7547.3 7652.2 7798.9 2588.8 2622.9 2665.5 2690.8 2768.0 38378.2 38756.4 38968.0 39190.0 39834.8 7128.6 7170.7 7198.8 7206.6 7285.1 15237.2 15261.6 15285.5 15446.0 15463.7 5720.4 5762.5 5819.2 5933.7 6008.3 3015.2 3114.7 3126.1 3207.6 3207.6 2366.9 2378.3 2386.2 2404.9 2448.2 348.4 412.3 417.5 443.0 443.4 442.5 448.5 452.1 480.4 490.5 5586.7 6016.8 6127.2 6293.5 6333.1 445.1 445.7 469.4 480.8 498.3 2944.4 2981.9 3028.1 3136.7 3136.8 43503.0 43535.3 44704.0 44762.8 44836.3 39491.2 40459.8 40531.2 40622.4 40935.4 36231.5 37587.0 37657.2 38138.6 38653.0 6163.4 6593.2 6593.4 6664.5 6752.6 25890.2 26309.7 26476.3 28370.6 29342.0 35444.5 35518.5 36149.1 36981.8 37001.5 5818.9 5848.0 5873.4 6131.1 6250.8 8635.1 8653.3 8885.8 8946.0 8955.8 8063.4 8213.9 8258.7 8462.6 8467.5 8280.2 8360.3 8452.4 8455.5 8464.5 7707.8 7765.8 7820.8 7897.4 8396.3 6799.7 6997.6 7466.1 7539.5 7549.3 7269.3 7284.1 7389.2 7541.3 7662.0 12:00:50 INFO - 2015-11-16 12:00:50,842 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:00:50 INFO - 2015-11-16 12:00:50,842 DEBUG : BROWSER_OUTPUT: 12:00:51 INFO - 2015-11-16 12:00:51,576 INFO : Browser exited with error code: 0 12:00:51 INFO - 2015-11-16 12:00:51,609 INFO : Completed test dromaeo_css (00:18:37) 12:00:51 INFO - 2015-11-16 12:00:51,609 INFO : Starting test kraken 12:00:51 INFO - 2015-11-16 12:00:51,609 DEBUG : operating with platform_type : mac_ 12:00:51 INFO - 2015-11-16 12:00:51,609 INFO : Initialising browser for kraken test... 12:00:51 INFO - 2015-11-16 12:00:51,626 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpFrbVzk/profile http://localhost:49268/getInfo.html 12:00:54 INFO - 2015-11-16 12:00:54,432 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:00:54 INFO - 2015-11-16 12:00:54,432 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:00:54 INFO - 2015-11-16 12:00:54,432 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:00:54 INFO - 2015-11-16 12:00:54,432 DEBUG : BROWSER_OUTPUT: __metrics 12:00:54 INFO - 2015-11-16 12:00:54,449 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:55 INFO - 2015-11-16 12:00:55,306 INFO : Browser initialized. 12:00:55 INFO - 2015-11-16 12:00:55,306 INFO : Running cycle 1/1 for kraken test... 12:00:55 INFO - 2015-11-16 12:00:55,306 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpFrbVzk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:01:07 INFO - 2015-11-16 12:01:07,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 230109184 12:01:07 INFO - 2015-11-16 12:01:07,494 DEBUG : BROWSER_OUTPUT: 12:01:10 INFO - 2015-11-16 12:01:10,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 12:01:11 INFO - 2015-11-16 12:01:11,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 285585408 12:01:11 INFO - 2015-11-16 12:01:11,061 DEBUG : BROWSER_OUTPUT: 12:01:14 INFO - 2015-11-16 12:01:14,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 12:01:14 INFO - 2015-11-16 12:01:14,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 297119744 12:01:14 INFO - 2015-11-16 12:01:14,810 DEBUG : BROWSER_OUTPUT: 12:01:18 INFO - 2015-11-16 12:01:18,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 12:01:18 INFO - 2015-11-16 12:01:18,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 281419776 12:01:18 INFO - 2015-11-16 12:01:18,911 DEBUG : BROWSER_OUTPUT: 12:01:21 INFO - 2015-11-16 12:01:21,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 12:01:21 INFO - 2015-11-16 12:01:21,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 283799552 12:01:21 INFO - 2015-11-16 12:01:21,880 DEBUG : BROWSER_OUTPUT: 12:01:24 INFO - 2015-11-16 12:01:24,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:01:25 INFO - 2015-11-16 12:01:25,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 283389952 12:01:25 INFO - 2015-11-16 12:01:25,028 DEBUG : BROWSER_OUTPUT: 12:01:28 INFO - 2015-11-16 12:01:28,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 12:01:29 INFO - 2015-11-16 12:01:29,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 282259456 12:01:29 INFO - 2015-11-16 12:01:29,264 DEBUG : BROWSER_OUTPUT: 12:01:33 INFO - 2015-11-16 12:01:33,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 12:01:33 INFO - 2015-11-16 12:01:33,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 280846336 12:01:33 INFO - 2015-11-16 12:01:33,688 DEBUG : BROWSER_OUTPUT: 12:01:37 INFO - 2015-11-16 12:01:37,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 12:01:37 INFO - 2015-11-16 12:01:37,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 281817088 12:01:37 INFO - 2015-11-16 12:01:37,638 DEBUG : BROWSER_OUTPUT: 12:01:39 INFO - 2015-11-16 12:01:39,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:01:40 INFO - 2015-11-16 12:01:40,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 317009920 12:01:40 INFO - 2015-11-16 12:01:40,018 DEBUG : BROWSER_OUTPUT: 12:01:42 INFO - 2015-11-16 12:01:42,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:01:42 INFO - 2015-11-16 12:01:42,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 318513152 12:01:42 INFO - 2015-11-16 12:01:42,776 DEBUG : BROWSER_OUTPUT: 12:01:45 INFO - 2015-11-16 12:01:45,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:01:45 INFO - 2015-11-16 12:01:45,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 325967872 12:01:45 INFO - 2015-11-16 12:01:45,831 DEBUG : BROWSER_OUTPUT: 12:01:48 INFO - 2015-11-16 12:01:48,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:01:49 INFO - 2015-11-16 12:01:49,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 327614464 12:01:49 INFO - 2015-11-16 12:01:49,509 DEBUG : BROWSER_OUTPUT: 12:01:52 INFO - 2015-11-16 12:01:52,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:53 INFO - 2015-11-16 12:01:53,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 327786496 12:01:53 INFO - 2015-11-16 12:01:53,274 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 12:01:55 INFO - 2015-11-16 12:01:55,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 387284992 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;133;137;134;132;133;131;137;138;147 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;190;168;191;207;165;189;186;160;205;165 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: |2;audio-dft;193;197;207;206;200;199;196;200;206;206 12:01:55 INFO - 2015-11-16 12:01:55,519 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;100;105;153;86;90;91;90;146;84 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;117;120;170;115;114;115;160;113;109;158 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;148;155;153;142;141;155;148;148;146 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;163;163;162;163;163;163;163;162;162 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;119;130;119;120;130;130;131;120;120 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;71;73;73;75;76;86;75;75 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;80;82;84;85;93;92;90;90;90;89 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;105;112;108;109;110;108;110;112;110 12:01:55 INFO - 2015-11-16 12:01:55,520 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;157;158;168;160;162;158;162;156;165;166 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;176;195;196;201;199;181;196;190;199;196 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;84;84;85;86;91;89;94;90;92;91 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1023 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:01:55 INFO - 2015-11-16 12:01:55,521 DEBUG : BROWSER_OUTPUT: __startTimestamp1447704115512__endTimestamp 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.40 Median:135.50 stddev:6.33 (4.7%) stddev-sans-first:4.87 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: Values: 122.0 133.0 137.0 134.0 132.0 133.0 131.0 137.0 138.0 147.0 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,522 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:182.60 Median:189.50 stddev:17.06 (9.0%) stddev-sans-first:17.88 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: Values: 190.0 168.0 191.0 207.0 165.0 189.0 186.0 160.0 205.0 165.0 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.00 Median:203.00 stddev:4.97 (2.4%) stddev-sans-first:4.34 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: Values: 193.0 197.0 207.0 206.0 200.0 199.0 196.0 200.0 206.0 206.0 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.20 Median:86.50 stddev:25.28 (29.2%) stddev-sans-first:26.12 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: Values: 87.0 100.0 105.0 153.0 86.0 90.0 91.0 90.0 146.0 84.0 12:01:55 INFO - 2015-11-16 12:01:55,523 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:129.10 Median:118.50 stddev:23.53 (19.9%) stddev-sans-first:24.54 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: Values: 117.0 120.0 170.0 115.0 114.0 115.0 160.0 113.0 109.0 158.0 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.50 Median:148.50 stddev:4.84 (3.3%) stddev-sans-first:5.13 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 155.0 153.0 142.0 141.0 155.0 148.0 148.0 146.0 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,524 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:161.90 Median:163.00 stddev:2.47 (1.5%) stddev-sans-first:0.50 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: Values: 155.0 163.0 163.0 162.0 163.0 163.0 163.0 163.0 162.0 162.0 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.80 Median:125.00 stddev:5.57 (4.5%) stddev-sans-first:5.63 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: Values: 119.0 119.0 130.0 119.0 120.0 130.0 130.0 131.0 120.0 120.0 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:75.00 stddev:4.29 (5.7%) stddev-sans-first:4.50 12:01:55 INFO - 2015-11-16 12:01:55,525 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 71.0 73.0 73.0 75.0 76.0 86.0 75.0 75.0 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:87.50 Median:90.00 stddev:4.43 (4.9%) stddev-sans-first:3.77 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 84.0 85.0 93.0 92.0 90.0 90.0 90.0 89.0 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:108.70 Median:110.00 stddev:2.87 (2.6%) stddev-sans-first:2.18 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 112.0 108.0 109.0 110.0 108.0 110.0 112.0 110.0 12:01:55 INFO - 2015-11-16 12:01:55,526 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:161.20 Median:162.00 stddev:4.10 (2.5%) stddev-sans-first:4.06 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: Values: 157.0 158.0 168.0 160.0 162.0 158.0 162.0 156.0 165.0 166.0 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:196.00 stddev:8.23 (4.2%) stddev-sans-first:6.04 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: Values: 176.0 195.0 196.0 201.0 199.0 181.0 196.0 190.0 199.0 196.0 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.60 Median:90.50 stddev:3.60 (4.0%) stddev-sans-first:3.41 12:01:55 INFO - 2015-11-16 12:01:55,527 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 86.0 91.0 89.0 94.0 90.0 92.0 91.0 12:01:55 INFO - 2015-11-16 12:01:55,528 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:01:55 INFO - 2015-11-16 12:01:55,528 DEBUG : BROWSER_OUTPUT: 12:01:56 INFO - 2015-11-16 12:01:56,296 INFO : Browser exited with error code: 0 12:01:56 INFO - 2015-11-16 12:01:56,357 INFO : Completed test kraken (00:01:04) 12:01:56 INFO - 2015-11-16 12:01:56,357 INFO : Starting test v8_7 12:01:56 INFO - 2015-11-16 12:01:56,357 DEBUG : operating with platform_type : mac_ 12:01:56 INFO - 2015-11-16 12:01:56,357 INFO : Initialising browser for v8_7 test... 12:01:56 INFO - 2015-11-16 12:01:56,374 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpnXQish/profile http://localhost:49268/getInfo.html 12:01:59 INFO - 2015-11-16 12:01:59,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:01:59 INFO - 2015-11-16 12:01:59,018 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:01:59 INFO - 2015-11-16 12:01:59,019 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:01:59 INFO - 2015-11-16 12:01:59,019 DEBUG : BROWSER_OUTPUT: __metrics 12:01:59 INFO - 2015-11-16 12:01:59,035 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:01:59 INFO - 2015-11-16 12:01:59,884 INFO : Browser initialized. 12:01:59 INFO - 2015-11-16 12:01:59,884 INFO : Running cycle 1/1 for v8_7 test... 12:01:59 INFO - 2015-11-16 12:01:59,884 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpnXQish/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:12 INFO - 2015-11-16 12:02:12,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 228544512 12:02:12 INFO - 2015-11-16 12:02:12,115 DEBUG : BROWSER_OUTPUT: 12:02:34 INFO - 2015-11-16 12:02:34,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49268/tests/v8_7/run.html (next: http://localhost:49268/tests/v8_7/run.html) 12:02:35 INFO - 2015-11-16 12:02:35,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 308891648 12:02:35 INFO - 2015-11-16 12:02:35,116 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,116 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:02:35 INFO - 2015-11-16 12:02:35,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: |0;Richards;205.5921052631579 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;254.25883549453343 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: |2;Encrypt;406.17384240454913 12:02:35 INFO - 2015-11-16 12:02:35,118 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7289.855072463768 12:02:35 INFO - 2015-11-16 12:02:35,119 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2398.0815347721823 12:02:35 INFO - 2015-11-16 12:02:35,119 DEBUG : BROWSER_OUTPUT: |5;Earley;1038.4215991692627 12:02:35 INFO - 2015-11-16 12:02:35,119 DEBUG : BROWSER_OUTPUT: |6;Boyer;16491.803278688523 12:02:35 INFO - 2015-11-16 12:02:35,119 DEBUG : BROWSER_OUTPUT: |7;RegExp;37943.3962264151 12:02:35 INFO - 2015-11-16 12:02:35,120 DEBUG : BROWSER_OUTPUT: |8;Splay;792.3930269413629 12:02:35 INFO - 2015-11-16 12:02:35,120 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7201.438848920863 12:02:35 INFO - 2015-11-16 12:02:35,120 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:02:35 INFO - 2015-11-16 12:02:35,120 DEBUG : BROWSER_OUTPUT: __startTimestamp1447704155115__endTimestamp 12:02:35 INFO - 2015-11-16 12:02:35,120 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:02:35 INFO - 2015-11-16 12:02:35,121 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:02:35 INFO - 2015-11-16 12:02:35,121 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,121 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:205.59 Median:205.59 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,121 DEBUG : BROWSER_OUTPUT: Values: 205.6 12:02:35 INFO - 2015-11-16 12:02:35,122 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,122 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:254.26 Median:254.26 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,122 DEBUG : BROWSER_OUTPUT: Values: 254.3 12:02:35 INFO - 2015-11-16 12:02:35,122 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,122 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:406.17 Median:406.17 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: Values: 406.2 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7289.86 Median:7289.86 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: Values: 7289.9 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2398.08 Median:2398.08 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,123 DEBUG : BROWSER_OUTPUT: Values: 2398.1 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1038.42 Median:1038.42 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: Values: 1038.4 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16491.80 Median:16491.80 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: Values: 16491.8 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,124 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:37943.40 Median:37943.40 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: Values: 37943.4 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: Values: 792.4 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7201.44 Median:7201.44 stddev:0.00 (0.0%) 12:02:35 INFO - 2015-11-16 12:02:35,125 DEBUG : BROWSER_OUTPUT: Values: 7201.4 12:02:35 INFO - 2015-11-16 12:02:35,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:02:35 INFO - 2015-11-16 12:02:35,126 DEBUG : BROWSER_OUTPUT: 12:02:35 INFO - 2015-11-16 12:02:35,879 INFO : Browser exited with error code: 0 12:02:35 INFO - 2015-11-16 12:02:35,904 INFO : Completed test v8_7 (00:00:39) 12:02:35 INFO - 2015-11-16 12:02:35,985 INFO : Completed test suite (00:20:22) 12:02:35 INFO - 2015-11-16 12:02:35,985 DEBUG : Working with test: dromaeo_css 12:02:35 INFO - 2015-11-16 12:02:35,985 DEBUG : Generating results file: dromaeo_css 12:02:35 INFO - 2015-11-16 12:02:35,986 DEBUG : Working with test: kraken 12:02:35 INFO - 2015-11-16 12:02:35,986 DEBUG : Generating results file: kraken 12:02:35 INFO - 2015-11-16 12:02:35,986 INFO : javascript benchmark 12:02:35 INFO - 2015-11-16 12:02:35,986 DEBUG : Working with test: v8_7 12:02:35 INFO - 2015-11-16 12:02:35,986 DEBUG : Generating results file: v8_7 12:02:35 INFO - 2015-11-16 12:02:35,987 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:02:36 INFO - 2015-11-16 12:02:36,045 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 12:02:36 INFO - 2015-11-16 12:02:36,045 DEBUG : process_Request line: dromaeo_css 5405.87 graph.html#tests=[[72,64,55]] 12:02:36 INFO - 2015-11-16 12:02:36,045 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:02:36 INFO - 2015-11-16 12:02:36,076 DEBUG : process_Request line: kraken 1898.20 graph.html#tests=[[232,64,55]] 12:02:36 INFO - 2015-11-16 12:02:36,076 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:02:36 INFO - 2015-11-16 12:02:36,108 DEBUG : process_Request line: v8_7 14663.52 graph.html#tests=[[230,64,55]] 12:02:36 INFO - 2015-11-16 12:02:36,109 INFO : javascript benchmark 12:02:36 INFO - 2015-11-16 12:02:36,112 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [265.5101338031332, 267.5184667598325, 267.5371607119683, 272.1427503364401, 273.68389510115816, 10638.893611063888, 10985.61550345738, 13159.473621055158, 13784.241866697328, 13790.103643263194, 11416.486258118384, 13680.589582312547, 13771.724565508684, 13794.10338328008, 14818.777718334233, 4267.4025636410925, 4347.087111706545, 4361.062371590107, 4385.956140438602, 4454.33185022246, 3103.829289389094, 3184.3153721949775, 4342.717723347972, 4384.714993525411, 4558.612517935962, 4552.08958208358, 4581.885452863672, 4653.790579423934, 4690.0, 4755.239161734124, 4605.078984203139, 4635.513271106519, 4694.037722266927, 4710.646701497367, 4722.38608980832, 4008.8596899108684, 4061.1268577256033, 4080.6531444827224, 4102.856400025985, 4110.958890411118, 16769.580760480963, 16851.494455166365, 16935.491935241964, 17054.488365349058, 17092.82907170925, 1661.808891977426, 1692.813790483046, 1702.6424450865209, 1741.6777896089263, 1831.8809277396927, 10671.626493072783, 10679.252452328341, 10808.891911080946, 10841.67474975752, 10868.239223254375, 1271.1800888426912, 1311.1282629776938, 1328.3491089366141, 1345.9730805383936, 1356.7422189783908, 44916.10167796659, 44972.0, 45847.54152458466, 47334.76332618349, 48286.0, 7194.568325900463, 7442.702291908371, 7519.73680921176, 7611.65747541362, 7662.923370766221, 9233.399829011092, 9279.304052195977, 9344.785177926962, 9371.953140234255, 9415.199708024895, 5454.754536045808, 5628.380878103405, 5704.372519022904, 5717.399673034354, 5746.367899531048, 5461.726913654381, 5501.944980550224, 5525.751341189656, 5531.142672885629, 5558.416366281563, 4470.619997300266, 4489.506154323022, 4532.909341813145, 4591.79336929839, 4600.171969045537, 1234.672811704899, 1312.5078095714107, 1312.9409176587076, 1323.1465704620466, 1343.5566263133142, 299.77666638354566, 327.675601154855, 340.8125530957963, 673.3973094080868, 734.3207533032031, 8210.137935516805, 8370.916290837136, 8855.291576673852, 9150.81698366029, 9643.517824108907, 351.75680228295585, 352.1934769378095, 352.2813460540469, 359.7985128328145, 362.55043745755603, 4306.2894622387585, 5102.08162530748, 5106.259592359087, 5162.793488260502, 5199.896002079937, 458344.0, 459783.0, 464606.0, 476311.0, 481668.0, 55388.723056385264, 56465.43534564684, 57287.71356143193, 58164.70917645469, 58257.0, 385.9363205071188, 387.2603327644242, 389.4742098167508, 392.7839688171494, 396.78771857056336, 8450.366222533457, 8531.274841638531, 8556.871646925425, 8723.651053958025, 8828.025794885738, 25954.48091038131, 26550.0, 26828.731712682624, 27640.585391218745, 27671.169864904085, 34657.826710866284, 34904.65095349014, 35050.298994020486, 35530.46704299489, 35596.28807423889, 4670.5329467053025, 4988.725620090785, 5027.824026159067, 5033.345665063518, 5067.011932673094, 9218.26253899673, 9369.85945210836, 9516.095970882756, 9570.56932438028, 9660.32377733552, 6692.364225398579, 6963.338482844122, 7061.470389720895, 8064.637091331021, 8119.106898241071, 7635.961820190863, 7808.141104478616, 7838.294553490213, 7883.526988380716, 7909.683612655429, 6887.276835932155, 7845.176256493214, 8131.674733010614, 8184.099749027483, 8390.874136887829, 4374.475062992461, 4442.600165985077, 4748.287756836502, 4861.878453038561, 4981.900361992813, 7344.669489873076, 7762.146163922077, 7967.521948683097, 8027.076886158166, 8085.070216925129], "dojo.html": [2521.1806162997027, 2545.249151500308, 2579.8323108997924, 2585.7284985076567, 2588.184721812629, 4024.818883150258, 4166.770827604484, 4173.624373806357, 4181.60274773896, 4315.395844581753, 4247.150569886027, 4293.914121717572, 4294.033842385462, 4346.934795978055, 4394.824207031715, 3671.477602312399, 3838.7888666123354, 3851.7496362736333, 3941.467901833259, 3995.6603688686496, 3935.4687117239237, 3943.7042221833335, 3992.6606238469767, 4055.6755459563165, 4094.8566800162002, 3813.9427908581392, 3850.1144736710435, 3877.3990031545154, 3956.030772460737, 3984.5816189300285, 3892.5912779158066, 3939.468171796799, 4001.1197536542204, 4002.5597184309704, 4041.3937909313545, 3932.6067393260732, 3939.862104826346, 3953.051267695761, 4037.899052523681, 4058.817353219112, 4126.649234815014, 4159.022629682022, 4166.979165104185, 4215.494140703136, 4265.232258193524, 4475.060237350161, 4541.0, 4602.401687780567, 4618.237990731525, 4668.929966050512, 4551.8179272829375, 4586.931196032062, 4603.261059669491, 4673.556012178838, 4677.228257337535, 3885.8251378687746, 4175.457190565207, 4177.101923086551, 4243.172581346669, 4312.935305970413, 4588.449386073693, 4589.770511474413, 4629.907401851944, 4713.67004309695, 4717.174494463455, 4317.913641727211, 4410.33844923264, 4423.623991960655, 4443.33349997503, 4513.593776560059, 4556.066006468666, 4587.853036740815, 4600.884977875513, 4619.5611416915335, 4652.813887444464, 4481.3726078349055, 4482.618977386894, 4544.840930567414, 4583.014651849869, 4649.976750116295, 4369.6722745794195, 4375.234333991602, 4476.239039363316, 4494.595486406239, 4543.477500087466, 3479.408500554912, 3499.772514786531, 3536.6463353664426, 3541.645835416438, 3577.5170352002147, 3180.840957952093, 3233.547303377529, 3234.4016356974034, 3244.8053116813066, 3262.1029216965526, 4130.194612050681, 4174.603412675791, 4275.230458517497, 4313.503947046067, 4330.935035974463, 4582.770861456914, 4635.814567417333, 4656.045510670305, 4699.577038066522, 4761.0, 4322.24360736876, 4325.178216138924, 4371.0, 4386.495553011381, 4434.246178149722, 3904.1996390740396, 3970.463987361727, 4013.5986401360215, 4047.210793895162, 4098.6516146127315, 4700.106979673851, 4752.382190315237, 4756.429228492603, 4766.809327626995, 4786.497417771084, 4606.700564463299, 4606.746628935441, 4628.861134165981, 4686.953130468652, 4735.573798358164, 4532.841350552715, 4604.102200070954, 4687.601553867959, 4695.366125573004, 4745.5966242869745, 4537.478190008192, 4549.249373853409, 4587.72473651582, 4618.46887607916, 4640.698354607075, 4578.954210457853, 4586.793594288199, 4644.535546445463, 4659.743714095757, 4684.953150468588, 4198.664106871504, 4401.911961760811, 4467.553244675506, 4481.686281960231, 4602.0, 4431.224535706303, 4531.093781243699, 4569.748663823389, 4572.565606267399, 4586.931196032129, 4343.956560434355, 4389.275769497997, 4406.889827754332, 4461.531539188469, 4488.64090872736, 4427.490838553479, 4432.889177770581, 4455.220336441174, 4461.598456138963, 4557.293619488984, 4471.977640111779, 4472.753998530112, 4499.955000450084, 4505.324201369821, 4509.842155524672], "mootools.html": [1255.9686007849798, 1326.1102928327132, 1402.698419839735, 1431.8424973252947, 1446.3202294921387, 5463.672179669223, 6070.484008859252, 6095.817125486232, 6334.398232167948, 6345.428911397973, 5772.826815195541, 5841.707914604274, 5865.530757539397, 5915.940840591604, 6004.189434426351, 1798.6043070524463, 1843.8709290349682, 1846.0, 1851.0837135617887, 1875.3155098389127, 1785.5446861050414, 1810.248746770089, 1814.1020195003425, 1822.7630408046934, 1853.3791179954665, 1823.2524664887399, 1823.6626224148574, 1854.4622059602766, 1875.746774185488, 1876.6059127583223, 1718.8109307976113, 1730.108993868159, 1760.559860034985, 1775.0237369446752, 1799.8119599444842, 1737.444017914268, 1757.77148970633, 1773.4413659697154, 1775.6981313176661, 1807.6565452564103, 5501.477359650827, 6096.878062438726, 6255.0, 6271.153394291758, 6328.335524769925, 3491.528643633128, 3689.262147570497, 3757.699384049297, 3809.1619843634357, 3900.0054985978677, 2316.200910685811, 2411.0958390603523, 2436.792872605831, 2452.3746444656676, 2472.418981539337, 680.0513283968885, 683.835879388948, 710.0627172132787, 724.8296650287178, 757.0, 8386.203310685476, 8398.118197589287, 8491.915080849174, 8507.659693612248, 8572.057073721886, 3565.5008298838184, 3705.777653340754, 3734.495843061152, 3739.1586892949413, 3758.680512156497, 7406.444516661272, 7476.626168691544, 7482.176960534337, 7486.850262994819, 7600.315971562586, 4046.7571945683353, 4092.7544347339253, 4100.323446631272, 4138.896527586834, 4146.253674338648, 3666.7983260920373, 3674.41209406499, 3678.4666223397458, 3702.3705969985167, 3714.814259287025, 2882.6829048804616, 2942.14677743452, 2950.601668774731, 2981.6123903892353, 2984.7612191024664, 923.6397804856111, 955.5317894231915, 957.3872721458272, 967.0764419978904, 973.3744646440462, 1019.6023550815188, 1037.7457522906936, 1041.1774697988656, 1054.9103326217357, 1063.7659714862718, 5919.526437885045, 5947.1376650385455, 6084.756609735649, 6097.542684298695, 6097.664628445478, 376.1705439505883, 377.8507489541616, 946.8769060022291, 963.3593660216018, 1003.5433877585681, 4675.368825208621, 4736.810527578928, 4755.785989630475, 4770.809167633256, 4781.187198176319, 6484.319146489645, 6539.836504087436, 6793.082933803972, 7302.525335853153, 7726.961365193138, 7404.518706284182, 7488.0, 7488.138864030598, 7561.962190189124, 7636.007319048599, 5596.0, 5631.605787594911, 5660.801871934463, 5730.713464326767, 5809.0, 5647.604667673223, 5674.375818660027, 5706.857328566819, 5763.193152958505, 5787.39232380594, 6156.107364432043, 6195.907061393992, 6257.249130104235, 6278.183836101278, 6291.087792270004, 6358.205224346957, 6459.192600924885, 6461.160049193575, 6519.8044058678315, 6618.1065556151225, 5627.409122042127, 5709.8287051388525, 5728.283964504437, 5757.510611598061, 5807.041838096667, 6108.08378743192, 6164.291106522807, 6167.383261673796, 6203.410675985955, 6213.502919766317, 5487.725613719218, 5689.089745640677, 5721.370649228498, 5750.971245143747, 5788.450097240755, 5553.250311208097, 5615.915761263503, 5667.801626943202, 5702.0, 5798.391168927371, 5526.115821468546, 5670.8015219467125, 5682.261306030189, 5710.400407957105, 5788.652680839163, 5210.296609957607, 5227.2420499028185, 5239.266502689703, 5277.155655095166, 5287.947120528899, 4816.373871396696, 5241.6068794839775, 5303.231031500333, 5318.946810531846, 5377.516023557742], "ext.html": [444.22704494180124, 447.8119189940225, 450.5967159392344, 451.75830930452213, 478.97021403981455, 25437.618435723456, 25477.74522254777, 25907.352316192104, 25988.480230395406, 31519.527207091855, 33138.17154571137, 33565.32869342612, 33826.49260261098, 34554.654453455456, 34648.0, 7142.642867856599, 7289.489735718502, 7292.015577896996, 7316.122065352165, 7438.181800001996, 6764.6617669116595, 6799.52403331767, 6822.897656535156, 7050.929490705079, 7241.058662373884, 8966.462012279284, 9027.729168124933, 9053.547322633842, 9118.17936385725, 9185.219256363218, 8806.0, 8879.11208879107, 8910.886139232596, 9022.5939832708, 9028.232600228988, 6542.869142617121, 6852.725890964355, 6869.587824730482, 8718.346124040723, 8854.804601378795, 31700.841495792603, 31786.0, 31859.362812743846, 32142.196445088826, 32537.0, 2294.701688780448, 2315.340128063494, 2449.216250799745, 2451.350392146083, 2496.0390249753796, 22109.778902211092, 22161.224357147585, 22376.776232237633, 22686.092556297728, 22916.541669166523, 1854.75888134543, 1861.5997560524552, 1884.9717254241198, 1950.0834607734341, 1983.771866235387, 220145.0, 220390.0, 224911.0, 225423.0, 226429.0, 45297.547024529995, 46003.0, 46545.0, 48223.75888120537, 48788.0, 56361.0, 57009.714951424976, 57161.42838571644, 57882.42117578854, 57921.71039144777, 11733.061355091571, 11847.466863991142, 11890.88109118915, 11970.700732481757, 12115.0, 8705.173008564303, 8816.75172830924, 8919.910800892038, 8954.552272386354, 9073.909260907307, 15864.206789660471, 16091.597710057342, 16152.434664786677, 16263.674726505404, 16311.42909998168, 6632.137822083098, 6800.727970881109, 6822.079019332326, 6955.8956615649795, 6960.129983752031, 722.3895808042196, 746.4588173574224, 773.9458237923292, 775.9379249660013, 782.1591788827034, 22719.88640056789, 23394.0, 23498.177563785528, 23821.0, 23822.88088559546, 823.4853216739538, 825.1336097098143, 826.1738261738262, 838.1995194589275, 854.3037424499014, 10737.946310268399, 10757.193210509244, 10915.0, 11059.281146725438, 11313.377764222882, 238082.0, 241648.0, 245392.0, 246127.0, 246204.0, 42652.09500907436, 42983.35524967128, 43034.56965430368, 44071.55928440738, 44127.33808992868, 1020.0768304684125, 1060.1995493402433, 1077.1436707817304, 1081.9459027048774, 1082.1451053667515, 20344.287949921683, 20742.274020409815, 20822.58354832925, 20844.47888802792, 20909.686354704994, 38454.0, 38758.80620596879, 38759.03102422349, 38871.6112838868, 39375.40936885892, 217589.0, 221218.0, 226510.0, 226703.0, 227011.0, 21247.78752212458, 21864.0, 22217.888910555343, 22403.775962240168, 23761.0, 25937.740622594287, 28300.0, 29432.705672942997, 30170.84914575413, 32437.026889193363, 26231.081912132984, 26393.0, 26544.469110618065, 26562.86718566395, 26739.33151671224, 25839.741602583734, 25854.87072564625, 26113.347166320993, 26293.4741305169, 26477.735222647527, 23950.28149155528, 24181.51636967286, 24457.75542244626, 28033.43933121367, 28079.43841123125, 22680.319590412313, 23900.760992389853, 24580.877095614407, 24816.751832481445, 25024.499510009333, 18158.90920545389, 18522.722159167355, 18532.722009170142, 18782.342618008304, 18819.341323053628], "prototype.html": [242.76330577686755, 252.29232004228137, 253.15067947037687, 253.79062273624243, 260.7952757085688, 4986.75066246688, 5060.848174554764, 5081.542661160494, 5104.438511763703, 5150.562202212816, 4815.759212039402, 4841.491643377448, 4897.020595880829, 4928.605711543077, 5015.9749201254035, 3734.495843061179, 3802.163524024717, 3807.1053302474033, 3837.4052021936504, 3846.1730727893496, 3810.8094595270263, 3830.291396091718, 3871.857801948418, 3887.611238876118, 3906.5507466641275, 3640.981795091034, 3690.4464330350393, 3759.3609086455367, 3803.0302272920503, 3822.617738226169, 3736.271427071722, 3767.05823544114, 3781.5651200111924, 3847.8460861565645, 3864.2851072551666, 3266.183454136466, 3274.4269752793166, 3309.635940046593, 3309.635940046617, 3310.4372256716415, 4718.457377401608, 4851.708897466128, 4852.539008794159, 4866.7566621668775, 4971.105201063807, 4063.0, 4283.700140990132, 4304.311310190355, 4324.632406245473, 4334.154839806239, 5207.921881171786, 5210.088234558937, 5245.554127899133, 5278.498542638482, 5318.388385335697, 3413.9829300853335, 3429.8456569454183, 3470.3059388122224, 3482.9303413931834, 3510.3856825055514, 5476.507114359727, 5487.533559647435, 5560.694161821139, 5565.805196818092, 5610.579206559483, 3502.4746288056485, 3524.0308915048054, 3548.769329993542, 3552.786832790041, 3567.8572857085946, 3463.5497385339745, 3590.24604832988, 3594.4428613564937, 3638.235970446183, 3647.963520364762, 4187.644050255702, 4231.174920890397, 4232.0054787125, 4270.402143699885, 4282.421873047161, 5287.762050707727, 5292.682439053669, 5342.225377320345, 5383.093129709991, 5396.217548455452, 1247.8377810884526, 1256.2399748152418, 1261.9432125554372, 1288.1498211180576, 1289.9871001289866, 793.714262865368, 813.0690359538296, 817.9263866252065, 820.2576668115365, 821.6836517940517, 5021.322121513549, 5064.240363945438, 5103.0, 5106.0, 5147.974260128675, 5450.509454149066, 5499.450054994469, 5563.666180029211, 5574.470425309589, 5622.0161471742285, 4911.778969946361, 5003.424606170264, 5041.8487445376695, 5121.206213036985, 5145.639805213599, 2914.3151359430517, 2914.6502419709773, 2941.97058029417, 2963.155500682295, 3009.3830764693184, 5646.378898321182, 5660.235868157828, 5689.288838895138, 5722.942770572325, 5800.071988481823, 5652.858678532987, 5688.146777983253, 5688.573356998241, 5710.428957104256, 5763.337216220105, 5587.720613969285, 5697.4302569742695, 5744.080947048536, 5764.654120752768, 5824.359320474659, 5533.059379905345, 5564.666120032811, 5571.60998730085, 5640.351359593699, 5671.120976248688, 5439.864003399946, 5461.590380721541, 5462.0, 5561.527270181918, 5583.441655834384, 5561.5272701820795, 5724.141378793214, 5738.8278351649515, 5772.740226689725, 5852.5317974561085, 3561.0207193021092, 3571.749977501654, 3592.2276710507367, 3618.3848745712767, 3630.3102410541915, 5520.254765606592, 5546.306711661043, 5582.720863956704, 5621.213030175697, 5658.405867383865, 5419.756110974937, 5438.728063596884, 5449.536789372948, 5469.535089517435, 5473.096939005179, 5262.657927234717, 5403.675779453245, 5445.2104444854485, 5517.255170552085, 5545.528630066328, 5280.841574752763, 5288.9735551322, 5407.972960135174, 5417.322834645669, 5435.641089727568, 5406.405295417422, 5445.1832225166545, 5454.972725136349, 5533.695646739468, 5537.723113844372, 5101.897962040813, 5288.206768984683, 5298.894022119459, 5425.294711687456, 5461.371942226695], "yui.html": [537.623663435595, 568.5224411494344, 590.6279044202151, 603.4585097542638, 623.557274335222, 10775.83836242456, 11172.720681982955, 11234.0, 11299.152563557725, 11330.433478326082, 10193.184545236381, 10275.12661423778, 10527.15782737381, 10536.894631053687, 10739.0, 570.7403131575144, 571.0378013048006, 574.2792795042216, 714.1537278325176, 717.1573401253519, 697.1077021412575, 715.2882881532882, 724.3119036914926, 725.6408078001397, 736.9410447164241, 737.2369597466624, 737.3842841227581, 742.6286856571714, 744.3449764207517, 750.9474336796427, 577.0882006429852, 591.914172444993, 595.0479233226846, 711.3171355498675, 732.1397358104233, 540.0872525432046, 542.4765101676861, 545.8498912798972, 549.3270743339417, 554.7115499940049, 10946.233763636548, 10972.396518191495, 11000.394978276192, 11101.611443599435, 11169.609063682732, 9079.909200908038, 9250.259979201648, 9374.0, 9656.95171524138, 9710.854337184948, 7406.333429991327, 7473.0, 7547.320741133324, 7652.2347765223585, 7798.883016754753, 2588.8058395620405, 2622.93442663933, 2665.5468570342896, 2690.825096368749, 2767.9758489358865, 38378.232435351136, 38756.41865372022, 38968.0, 39190.0, 39834.800825995684, 7128.6435678215885, 7170.749023784247, 7198.820029499305, 7206.603636800026, 7285.052943117361, 15237.238138093051, 15261.6184595386, 15285.465008724863, 15446.0, 15463.690726185638, 5720.427957204246, 5762.4525670061275, 5819.185314056035, 5933.673647949404, 6008.309044459856, 3015.1557563882147, 3114.7352475039875, 3126.1403114143336, 3207.5990501187352, 3207.6150861896253, 2366.9053237870635, 2378.2865140457793, 2386.1648423051793, 2404.9038038478616, 2448.192096608115, 348.3503266408131, 412.2888018168635, 417.5156818091, 442.9723042541273, 443.4456928838951, 442.54638995030353, 448.4887228559445, 452.1431886574922, 480.4210925834361, 490.53644306130366, 5586.748596313176, 6016.819495415057, 6127.172831667757, 6293.527985401113, 6333.081703153109, 445.1297712971134, 445.6635240393482, 469.3640117640548, 480.81488626878206, 498.2501335490064, 2944.425836961772, 2981.910542683723, 3028.1067085209916, 3136.6706495818066, 3136.780425370248, 43503.0, 43535.34696979548, 44704.0, 44762.77618611951, 44836.3274550882, 39491.2101757969, 40459.79770101131, 40531.189376212904, 40622.39066414006, 40935.38596920989, 36231.4565281521, 37587.0, 37657.246855062745, 38138.61861381406, 38653.0, 6163.35284795108, 6593.241777195684, 6593.406593406617, 6664.4668426524795, 6752.628605426748, 25890.22329330123, 26309.736902630728, 26476.338091547866, 28370.57444138298, 29342.0, 35444.46833297554, 35518.46722299116, 36149.09627259339, 36981.81509092437, 37001.51993920213, 5818.883622327615, 5848.0, 5873.353931067664, 6131.080337949344, 6250.812475625738, 8635.136486351315, 8653.264472519906, 8885.777855553662, 8945.955270223607, 8955.820883582162, 8063.435559510778, 8213.876791848008, 8258.710945116893, 8462.619182136696, 8467.49195048299, 8280.213379728915, 8360.289375402916, 8452.36607254446, 8455.492670439793, 8464.492130472192, 7707.845843083219, 7765.844683106419, 7820.765377038698, 7897.368210543258, 8396.328293736364, 6799.694013769491, 6997.580145191305, 7466.104067511933, 7539.472236943361, 7549.282818132268, 7269.284719434059, 7284.125904891235, 7389.224131466119, 7541.283578060075, 7662.0]}, "summary": {"lowerIsBetter": false, "suite": 5405.867958391879, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5968.664684792027, "unit": "ms", "value": 5968.664684792027}, "dojo.html": {"lowerIsBetter": false, "filtered": 4233.1343125429585, "unit": "ms", "value": 4233.1343125429585}, "mootools.html": {"lowerIsBetter": false, "filtered": 3592.407212034725, "unit": "ms", "value": 3592.407212034725}, "ext.html": {"lowerIsBetter": false, "filtered": 14409.592582271227, "unit": "ms", "value": 14409.592582271227}, "prototype.html": {"lowerIsBetter": false, "filtered": 3964.7362939171735, "unit": "ms", "value": 3964.7362939171735}, "yui.html": {"lowerIsBetter": false, "filtered": 4812.355158299421, "unit": "ms", "value": 4812.355158299421}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1447702933, "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": "20151116095835", "branch": "Fx-Team", "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93"}}, {"talos_counters": {}, "results": {"audio-dft": [193.0, 197.0, 207.0, 206.0, 200.0, 199.0, 196.0, 200.0, 206.0, 206.0], "ai-astar": [122.0, 133.0, 137.0, 134.0, 132.0, 133.0, 131.0, 137.0, 138.0, 147.0], "imaging-gaussian-blur": [149.0, 148.0, 155.0, 153.0, 142.0, 141.0, 155.0, 148.0, 148.0, 146.0], "audio-beat-detection": [190.0, 168.0, 191.0, 207.0, 165.0, 189.0, 186.0, 160.0, 205.0, 165.0], "json-stringify-tinderbox": [80.0, 82.0, 84.0, 85.0, 93.0, 92.0, 90.0, 90.0, 90.0, 89.0], "stanford-crypto-pbkdf2": [176.0, 195.0, 196.0, 201.0, 199.0, 181.0, 196.0, 190.0, 199.0, 196.0], "json-parse-financial": [73.0, 71.0, 71.0, 73.0, 73.0, 75.0, 76.0, 86.0, 75.0, 75.0], "stanford-crypto-sha256-iterative": [84.0, 84.0, 85.0, 86.0, 91.0, 89.0, 94.0, 90.0, 92.0, 91.0], "audio-fft": [87.0, 100.0, 105.0, 153.0, 86.0, 90.0, 91.0, 90.0, 146.0, 84.0], "imaging-darkroom": [155.0, 163.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 162.0], "stanford-crypto-ccm": [157.0, 158.0, 168.0, 160.0, 162.0, 158.0, 162.0, 156.0, 165.0, 166.0], "audio-oscillator": [117.0, 120.0, 170.0, 115.0, 114.0, 115.0, 160.0, 113.0, 109.0, 158.0], "stanford-crypto-aes": [103.0, 105.0, 112.0, 108.0, 109.0, 110.0, 108.0, 110.0, 112.0, 110.0], "imaging-desaturate": [119.0, 119.0, 130.0, 119.0, 120.0, 130.0, 130.0, 131.0, 120.0, 120.0]}, "summary": {"lowerIsBetter": true, "suite": 1898.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 103.2, "unit": "ms", "value": 103.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 192.9, "unit": "ms", "value": 192.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 182.6, "unit": "ms", "value": 182.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 161.2, "unit": "ms", "value": 161.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 161.9, "unit": "ms", "value": 161.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.8, "unit": "ms", "value": 74.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 129.1, "unit": "ms", "value": 129.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 134.4, "unit": "ms", "value": 134.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 201.0, "unit": "ms", "value": 201.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.6, "unit": "ms", "value": 88.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 87.5, "unit": "ms", "value": 87.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 148.5, "unit": "ms", "value": 148.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 108.7, "unit": "ms", "value": 108.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 123.8, "unit": "ms", "value": 123.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1447702933, "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": "20151116095835", "branch": "Fx-Team", "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93"}}, {"talos_counters": {}, "results": {"DeltaBlue": [254.25883549453343], "Encrypt": [406.17384240454913], "NavierStokes": [7201.438848920863], "Decrypt": [7289.855072463768], "Splay": [792.3930269413629], "Richards": [205.5921052631579], "RegExp": [37943.3962264151], "Earley": [1038.4215991692627], "Boyer": [16491.803278688523], "RayTrace": [2398.0815347721823]}, "summary": {"lowerIsBetter": false, "suite": 14663.520700380868, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 260.0420939999999, "unit": "score", "value": 260.0420939999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 655.3376220000002, "unit": "score", "value": 655.3376220000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 206.06993006993, "unit": "score", "value": 206.06993006993}, "Decrypt": {"lowerIsBetter": false, "filtered": 36.51389463220679, "unit": "score", "value": 36.51389463220679}, "Splay": {"lowerIsBetter": false, "filtered": 102.84164200000004, "unit": "score", "value": 102.84164200000004}, "RegExp": {"lowerIsBetter": false, "filtered": 24.00905271009449, "unit": "score", "value": 24.00905271009449}, "Richards": {"lowerIsBetter": false, "filtered": 171.70892800000001, "unit": "score", "value": 171.70892800000001}, "Earley": {"lowerIsBetter": false, "filtered": 641.8038690000001, "unit": "score", "value": 641.8038690000001}, "Boyer": {"lowerIsBetter": false, "filtered": 40.4117723658052, "unit": "score", "value": 40.4117723658052}, "RayTrace": {"lowerIsBetter": false, "filtered": 308.57541299999986, "unit": "score", "value": 308.57541299999986}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1447702933, "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": "20151116095835", "branch": "Fx-Team", "revision": "647f70a15615ce77b1eb74bd73df36a35576bc93"}}] 12:02:36 INFO - RETURN: dromaeo_css: 5405.87 12:02:36 INFO - RETURN: kraken: 1898.20 12:02:36 INFO - RETURN: v8_7: 14663.52 12:02:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14663.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1898.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5405.87"}}} 12:02:36 INFO - Return code: 0 12:02:36 INFO - # TBPL SUCCESS # 12:02:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:02:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:02:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:02:36 INFO - 2015-11-16 12:02:36.207 screenresolution[1660:9968] starting screenresolution argv=screenresolution get 12:02:36 INFO - 2015-11-16 12:02:36.213 screenresolution[1660:9968] Display 0: 1600x1200x32@60 12:02:36 INFO - 2015-11-16 12:02:36.221 screenresolution[1661:9972] starting screenresolution argv=screenresolution list 12:02:36 INFO - Available Modes on Display 0 12:02:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:02:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:02:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:02:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:02:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:02:36 INFO - Intel HD Graphics 3000: 12:02:36 INFO - Chipset Model: Intel HD Graphics 3000 12:02:36 INFO - Type: GPU 12:02:36 INFO - Bus: Built-In 12:02:36 INFO - VRAM (Total): 512 MB 12:02:36 INFO - VRAM (Dynamic, Max): 10 12:02:36 INFO - Vendor: Intel (0x8086) 12:02:36 INFO - Device ID: 0x0116 12:02:36 INFO - Revision ID: 0x0009 12:02:36 INFO - Displays: 12:02:36 INFO - Display: 12:02:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:02:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:02:36 INFO - Display Serial Number: 1600x1200 60 12:02:36 INFO - Main Display: Yes 12:02:36 INFO - Mirror: Off 12:02:36 INFO - Online: Yes 12:02:36 INFO - Rotation: Supported 12:02:36 INFO - Return code: 0 12:02:36 INFO - Running post-action listener: _resource_record_post_action 12:02:36 INFO - Running post-run listener: _resource_record_post_run 12:02:37 INFO - Total resource usage - Wall time: 1268s; CPU: 30.0%; Read bytes: 42742784; Write bytes: 688053248; Read time: 5112; Write time: 44409 12:02:37 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 337459712; Write bytes: 333694976; Read time: 38950; Write time: 4486 12:02:37 INFO - run-tests - Wall time: 1224s; CPU: 30.0%; Read bytes: 41747456; Write bytes: 343995392; Read time: 4784; Write time: 39477 12:02:37 INFO - Running post-run listener: _upload_blobber_files 12:02:37 INFO - Blob upload gear active. 12:02:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:02:37 INFO - Copying logs to upload dir... 12:02:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1331.554634 ========= master_lag: 2.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2015-11-16 12:02:40.320855) ========= ========= Started set props: build_url (results: 0, elapsed: 5 secs) (at 2015-11-16 12:02:40.324032) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010710 build_url: 'https://queue.taskcluster.net/v1/task/VOZhJfqnT564bvy0MHnh9g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 5.07 ========= ========= Finished set props: build_url (results: 0, elapsed: 5 secs) (at 2015-11-16 12:02:45.406585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-16 12:02:45.406929) ========= 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.reGAV4Dhwt/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.yB1FPBi9fq/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/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.005656 ========= master_lag: 4.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2015-11-16 12:02:49.773579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 12:02:49.778119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 12:02:49.897332) ========= ========= Total master_lag: 12.26 =========