builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0053 starttime: 1447982219.08 results: success (0) buildid: 20151119135111 builduid: 96f7efb7a6704da0b5a50b9f3aff177e revision: 0920dee3c3036861bfe0f32342cdced4cabfb8df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.077517) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.078144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.078523) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005514 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.100621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.100940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.117522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.117982) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005594 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.166751) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.167083) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.167428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.167697) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False --2015-11-19 17:16:59-- 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% 8.45M=0.001s 2015-11-19 17:16:59 (8.45 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.362233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.362615) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025734 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:16:59.410900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 17:16:59.411241) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0920dee3c3036861bfe0f32342cdced4cabfb8df --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 0920dee3c3036861bfe0f32342cdced4cabfb8df --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False 2015-11-19 17:16:59,484 truncating revision to first 12 chars 2015-11-19 17:16:59,484 Setting DEBUG logging. 2015-11-19 17:16:59,484 attempt 1/10 2015-11-19 17:16:59,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0920dee3c303?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 17:17:00,479 unpacking tar archive at: fx-team-0920dee3c303/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 17:17:00.659725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 17:17:00.661333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 17:17:00.674218) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 17:17:00.674665) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 17:17:00.675225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-19 17:17:00.675606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False 17:17:00 INFO - MultiFileLogger online at 20151119 17:17:00 in /builds/slave/test 17:17:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:17:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:00 INFO - {'append_to_log': False, 17:17:00 INFO - 'base_work_dir': '/builds/slave/test', 17:17:00 INFO - 'blob_upload_branch': 'Fx-Team', 17:17:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:00 INFO - 'branch': 'Fx-Team', 17:17:00 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:00 INFO - 'config_files': ('talos/mac_config.py',), 17:17:00 INFO - 'default_actions': ('clobber', 17:17:00 INFO - 'read-buildbot-config', 17:17:00 INFO - 'download-and-extract', 17:17:00 INFO - 'populate-webroot', 17:17:00 INFO - 'create-virtualenv', 17:17:00 INFO - 'install', 17:17:00 INFO - 'run-tests'), 17:17:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:00 INFO - 'download_minidump_stackwalk': True, 17:17:00 INFO - 'download_symbols': 'ondemand', 17:17:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:00 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:00 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:00 INFO - 'installer_path': 'installer.exe', 17:17:00 INFO - 'log_level': 'info', 17:17:00 INFO - 'log_name': 'talos', 17:17:00 INFO - 'log_to_console': True, 17:17:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:17:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:17:00 INFO - 'opt_config_files': (), 17:17:00 INFO - 'pip_index': False, 17:17:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:00 INFO - 'cmd': ('bash', 17:17:00 INFO - '-c', 17:17:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:00 INFO - 'enabled': True, 17:17:00 INFO - 'halt_on_failure': False, 17:17:00 INFO - 'name': 'check_screen_resolution'},), 17:17:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:00 INFO - 'cmd': ('bash', 17:17:00 INFO - '-c', 17:17:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:00 INFO - 'enabled': True, 17:17:00 INFO - 'halt_on_failure': False, 17:17:00 INFO - 'name': 'check_screen_resolution'},), 17:17:00 INFO - 'run_cmd_checks_enabled': True, 17:17:00 INFO - 'sps_profile': False, 17:17:00 INFO - 'sps_profile_interval': 0, 17:17:00 INFO - 'suite': 'dromaeojs-e10s', 17:17:00 INFO - 'system_bits': '64', 17:17:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:00 INFO - 'title': 't-yosemite-r7-0053', 17:17:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:00 INFO - 'use_talos_json': True, 17:17:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:00 INFO - 'work_dir': 'build'} 17:17:00 INFO - ##### 17:17:00 INFO - ##### Running clobber step. 17:17:00 INFO - ##### 17:17:00 INFO - Running pre-action listener: _resource_record_pre_action 17:17:00 INFO - Running main action method: clobber 17:17:00 INFO - rmtree: /builds/slave/test/build 17:17:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - ##### 17:17:02 INFO - ##### Running read-buildbot-config step. 17:17:02 INFO - ##### 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: read_buildbot_config 17:17:02 INFO - Using buildbot properties: 17:17:02 INFO - { 17:17:02 INFO - "properties": { 17:17:02 INFO - "buildnumber": 5, 17:17:02 INFO - "product": "firefox", 17:17:02 INFO - "script_repo_revision": "production", 17:17:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:17:02 INFO - "repository": "", 17:17:02 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:17:02 INFO - "buildid": "20151119135111", 17:17:02 INFO - "slavename": "t-yosemite-r7-0053", 17:17:02 INFO - "pgo_build": "False", 17:17:02 INFO - "basedir": "/builds/slave/test", 17:17:02 INFO - "project": "", 17:17:02 INFO - "platform": "yosemite_r7", 17:17:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:17:02 INFO - "slavebuilddir": "test", 17:17:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:17:02 INFO - "branch": "fx-team", 17:17:02 INFO - "repo_path": "integration/fx-team", 17:17:02 INFO - "stage_platform": "macosx64", 17:17:02 INFO - "builduid": "96f7efb7a6704da0b5a50b9f3aff177e", 17:17:02 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 17:17:02 INFO - }, 17:17:02 INFO - "sourcestamp": { 17:17:02 INFO - "repository": "", 17:17:02 INFO - "hasPatch": false, 17:17:02 INFO - "project": "", 17:17:02 INFO - "branch": "fx-team-macosx64-talos", 17:17:02 INFO - "changes": [ 17:17:02 INFO - { 17:17:02 INFO - "category": null, 17:17:02 INFO - "files": [ 17:17:02 INFO - { 17:17:02 INFO - "url": null, 17:17:02 INFO - "name": "https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:17:02 INFO - } 17:17:02 INFO - ], 17:17:02 INFO - "repository": "", 17:17:02 INFO - "rev": "0920dee3c3036861bfe0f32342cdced4cabfb8df", 17:17:02 INFO - "who": "mbrubeck@mozilla.com", 17:17:02 INFO - "when": 1447976940, 17:17:02 INFO - "number": 6685893, 17:17:02 INFO - "comments": "Bug 967982 - Show findbar after unsuccessful Find Again [r=mikedeboer]", 17:17:02 INFO - "project": "", 17:17:02 INFO - "at": "Thu 19 Nov 2015 15:49:00", 17:17:02 INFO - "branch": "fx-team-macosx64-talos", 17:17:02 INFO - "revlink": "", 17:17:02 INFO - "properties": [ 17:17:02 INFO - [ 17:17:02 INFO - "buildid", 17:17:02 INFO - "20151119135111", 17:17:02 INFO - "Change" 17:17:02 INFO - ], 17:17:02 INFO - [ 17:17:02 INFO - "builduid", 17:17:02 INFO - "96f7efb7a6704da0b5a50b9f3aff177e", 17:17:02 INFO - "Change" 17:17:02 INFO - ], 17:17:02 INFO - [ 17:17:02 INFO - "pgo_build", 17:17:02 INFO - "False", 17:17:02 INFO - "Change" 17:17:02 INFO - ] 17:17:02 INFO - ], 17:17:02 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 17:17:02 INFO - } 17:17:02 INFO - ], 17:17:02 INFO - "revision": "0920dee3c3036861bfe0f32342cdced4cabfb8df" 17:17:02 INFO - } 17:17:02 INFO - } 17:17:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:17:02 INFO - Running post-action listener: _resource_record_post_action 17:17:02 INFO - ##### 17:17:02 INFO - ##### Running download-and-extract step. 17:17:02 INFO - ##### 17:17:02 INFO - Running pre-action listener: _resource_record_pre_action 17:17:02 INFO - Running main action method: download_and_extract 17:17:02 INFO - mkdir: /builds/slave/test/build/tests 17:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:02 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json 17:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json 17:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:17:03 INFO - Downloaded 1149 bytes. 17:17:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:17:03 INFO - Using the following test package requirements: 17:17:03 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:17:03 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:17:03 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'jsshell-mac.zip'], 17:17:03 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:17:03 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:17:03 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:17:03 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:17:03 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:17:03 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:17:03 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:17:03 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:17:03 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:17:03 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')]} 17:17:03 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:04 INFO - Downloaded 17524860 bytes. 17:17:04 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 17:17:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:17:07 INFO - Return code: 0 17:17:07 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 17:17:07 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')]} 17:17:07 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:08 INFO - Downloaded 17524860 bytes. 17:17:08 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 17:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:17:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:17:12 INFO - Return code: 0 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:12 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:17:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:17:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:17:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:13 INFO - Downloaded 11130997 bytes. 17:17:13 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 17:17:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:17:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:17:13 INFO - Return code: 0 17:17: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')]} 17:17:13 INFO - https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8L5Ls64XRY2XBK26TAEC7Q/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 17:17:16 INFO - Downloaded 109368599 bytes. 17:17:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:17:16 INFO - mkdir: /builds/slave/test/properties 17:17:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:16 INFO - Contents: 17:17:16 INFO - build_url:https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:17:16 INFO - Running post-action listener: _resource_record_post_action 17:17:16 INFO - Running post-action listener: set_extra_try_arguments 17:17:16 INFO - ##### 17:17:16 INFO - ##### Running populate-webroot step. 17:17:16 INFO - ##### 17:17:16 INFO - Running pre-action listener: _resource_record_pre_action 17:17:16 INFO - Running main action method: populate_webroot 17:17:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:16 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:17:16 INFO - '../fennec_ids.txt'], 17:17:16 INFO - 'tests': ['tcheck2']}, 17:17:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:16 INFO - '--tppagecycles', 17:17:16 INFO - '7'], 17:17:16 INFO - 'tests': ['tsvgm']}}, 17:17:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:17:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:17:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:17:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'tests': ['damp', 'tps']}, 17:17:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['damp', 'tps']}, 17:17:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:17:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:16 INFO - 'other': {'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'other_l64': {'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'other_nol64': {'tests': ['a11yr', 17:17:16 INFO - 'ts_paint', 17:17:16 INFO - 'tpaint', 17:17:16 INFO - 'sessionrestore', 17:17:16 INFO - 'sessionrestore_no_auto_restore']}, 17:17:16 INFO - 'svgr': {'tests': ['tsvgx', 17:17:16 INFO - 'tsvgr_opacity', 17:17:16 INFO - 'tart', 17:17:16 INFO - 'tscrollx', 17:17:16 INFO - 'cart']}, 17:17:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['tsvgx', 17:17:16 INFO - 'tsvgr_opacity', 17:17:16 INFO - 'tart', 17:17:16 INFO - 'tscrollx', 17:17:16 INFO - 'cart']}, 17:17:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'tests': ['tp5o']}, 17:17:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'talos_options': ['--e10s'], 17:17:16 INFO - 'tests': ['tp5o']}, 17:17:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'talos_options': ['--xperf_path', 17:17:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:16 INFO - 'tests': ['tp5n']}, 17:17:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:16 INFO - 'talos_options': ['--e10s', 17:17:16 INFO - '--xperf_path', 17:17:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:16 INFO - 'tests': ['tp5n']}}, 17:17:16 INFO - 'talos.zip': {'path': '', 17:17:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:16 INFO - Running post-action listener: _resource_record_post_action 17:17:16 INFO - ##### 17:17:16 INFO - ##### Running create-virtualenv step. 17:17:16 INFO - ##### 17:17:16 INFO - Running pre-action listener: _resource_record_pre_action 17:17:16 INFO - Running main action method: create_virtualenv 17:17:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:16 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 17:17:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:16 INFO - Using real prefix '/tools/python27' 17:17:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:20 INFO - Installing pip.................done. 17:17:20 INFO - Return code: 0 17:17:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:20 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 17:17:20 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 17:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:20 INFO - 'HOME': '/Users/cltbld', 17:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:20 INFO - 'LOGNAME': 'cltbld', 17:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:20 INFO - 'MOZ_NO_REMOTE': '1', 17:17:20 INFO - 'NO_EM_RESTART': '1', 17:17:20 INFO - 'PAGER': '/bin/cat', 17:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:20 INFO - 'PWD': '/builds/slave/test', 17:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:20 INFO - 'SHELL': '/bin/bash', 17:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:20 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:20 INFO - 'USER': 'cltbld', 17:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:20 INFO - 'XPC_FLAGS': '0x0', 17:17:20 INFO - 'XPC_SERVICE_NAME': '0', 17:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:20 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 17:17:20 INFO - Cleaning up... 17:17:20 INFO - Return code: 0 17:17:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:20 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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:20 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 17:17:20 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 17:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:20 INFO - 'HOME': '/Users/cltbld', 17:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:20 INFO - 'LOGNAME': 'cltbld', 17:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:20 INFO - 'MOZ_NO_REMOTE': '1', 17:17:20 INFO - 'NO_EM_RESTART': '1', 17:17:20 INFO - 'PAGER': '/bin/cat', 17:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:20 INFO - 'PWD': '/builds/slave/test', 17:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:20 INFO - 'SHELL': '/bin/bash', 17:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:20 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:20 INFO - 'USER': 'cltbld', 17:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:20 INFO - 'XPC_FLAGS': '0x0', 17:17:20 INFO - 'XPC_SERVICE_NAME': '0', 17:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:20 INFO - Downloading/unpacking psutil>=0.7.1 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:23 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:17:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:23 INFO - Installing collected packages: psutil 17:17:23 INFO - Running setup.py install for psutil 17:17:23 INFO - building 'psutil._psutil_osx' extension 17:17:23 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 INFO - building 'psutil._psutil_posix' extension 17:17:24 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 17:17:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:24 INFO - ^ 17:17:24 INFO - 1 warning generated. 17:17:24 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 17:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:24 INFO - Successfully installed psutil 17:17:24 INFO - Cleaning up... 17:17:24 INFO - Return code: 0 17:17:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:24 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 17:17:24 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 17:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:24 INFO - 'HOME': '/Users/cltbld', 17:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:24 INFO - 'LOGNAME': 'cltbld', 17:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:24 INFO - 'MOZ_NO_REMOTE': '1', 17:17:24 INFO - 'NO_EM_RESTART': '1', 17:17:24 INFO - 'PAGER': '/bin/cat', 17:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:24 INFO - 'PWD': '/builds/slave/test', 17:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:24 INFO - 'SHELL': '/bin/bash', 17:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:24 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:24 INFO - 'USER': 'cltbld', 17:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:24 INFO - 'XPC_FLAGS': '0x0', 17:17:24 INFO - 'XPC_SERVICE_NAME': '0', 17:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:27 INFO - Installing collected packages: mozsystemmonitor 17:17:27 INFO - Running setup.py install for mozsystemmonitor 17:17:27 INFO - Successfully installed mozsystemmonitor 17:17:27 INFO - Cleaning up... 17:17:27 INFO - Return code: 0 17:17:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', '--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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:27 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 17:17:27 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 17:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:27 INFO - 'HOME': '/Users/cltbld', 17:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:27 INFO - 'LOGNAME': 'cltbld', 17:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:27 INFO - 'MOZ_NO_REMOTE': '1', 17:17:27 INFO - 'NO_EM_RESTART': '1', 17:17:27 INFO - 'PAGER': '/bin/cat', 17:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:27 INFO - 'PWD': '/builds/slave/test', 17:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:27 INFO - 'SHELL': '/bin/bash', 17:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:27 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:27 INFO - 'USER': 'cltbld', 17:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:27 INFO - 'XPC_FLAGS': '0x0', 17:17:27 INFO - 'XPC_SERVICE_NAME': '0', 17:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:27 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:29 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 17:17:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 INFO - Downloading docopt-0.6.1.tar.gz 17:17:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:30 INFO - Running setup.py install for blobuploader 17:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:31 INFO - Running setup.py install for requests 17:17:31 INFO - Running setup.py install for docopt 17:17:31 INFO - Successfully installed blobuploader requests docopt 17:17:31 INFO - Cleaning up... 17:17:31 INFO - Return code: 0 17:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:31 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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:31 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 17:17:31 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 17:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:31 INFO - 'HOME': '/Users/cltbld', 17:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:31 INFO - 'LOGNAME': 'cltbld', 17:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:31 INFO - 'MOZ_NO_REMOTE': '1', 17:17:31 INFO - 'NO_EM_RESTART': '1', 17:17:31 INFO - 'PAGER': '/bin/cat', 17:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:31 INFO - 'PWD': '/builds/slave/test', 17:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:31 INFO - 'SHELL': '/bin/bash', 17:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:31 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:31 INFO - 'USER': 'cltbld', 17:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:31 INFO - 'XPC_FLAGS': '0x0', 17:17:31 INFO - 'XPC_SERVICE_NAME': '0', 17:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ljxCht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4fobAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-oPFXw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-E8wssy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-OT4aAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-aqfWTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-x0Xg4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-gLdV4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-cq9R2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:32 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-GUvYCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-fXXjay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-oC973_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-_9kj9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-DRQtH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Y4lCgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ywvI_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:33 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-kQZ9GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:33 INFO - Running setup.py install for manifestparser 17:17:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:33 INFO - Running setup.py install for mozcrash 17:17:34 INFO - Running setup.py install for mozdebug 17:17:34 INFO - Running setup.py install for mozdevice 17:17:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozfile 17:17:34 INFO - Running setup.py install for mozhttpd 17:17:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozinfo 17:17:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozInstall 17:17:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:34 INFO - Running setup.py install for mozleak 17:17:35 INFO - Running setup.py install for mozlog 17:17:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for moznetwork 17:17:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozprocess 17:17:35 INFO - Running setup.py install for mozprofile 17:17:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozrunner 17:17:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:35 INFO - Running setup.py install for mozscreenshot 17:17:36 INFO - Running setup.py install for moztest 17:17:36 INFO - Running setup.py install for mozversion 17:17:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:36 INFO - Cleaning up... 17:17:36 INFO - Return code: 0 17:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:36 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')]} 17:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:36 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')]} 17:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:36 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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:36 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 17:17:36 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 17:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:36 INFO - 'HOME': '/Users/cltbld', 17:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:36 INFO - 'LOGNAME': 'cltbld', 17:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:36 INFO - 'MOZ_NO_REMOTE': '1', 17:17:36 INFO - 'NO_EM_RESTART': '1', 17:17:36 INFO - 'PAGER': '/bin/cat', 17:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:36 INFO - 'PWD': '/builds/slave/test', 17:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:36 INFO - 'SHELL': '/bin/bash', 17:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:36 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:36 INFO - 'USER': 'cltbld', 17:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:36 INFO - 'XPC_FLAGS': '0x0', 17:17:36 INFO - 'XPC_SERVICE_NAME': '0', 17:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ydQFrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-AKEZOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-BS5Zah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:36 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)) 17:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-2as1Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-2ZZ8Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-YcuwL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Cdrwfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-QxRYm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-0YrxHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-2LLGag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-oJiOUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-DCIDqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:37 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)) 17:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:37 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-q2aF3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:38 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)) 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-haagCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:38 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)) 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-wJahu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:38 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)) 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-REEaHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:38 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)) 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:38 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Z50hNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:40 INFO - Downloading blessings-1.5.1.tar.gz 17:17:40 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 17:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:40 INFO - Installing collected packages: blessings 17:17:40 INFO - Running setup.py install for blessings 17:17:40 INFO - Successfully installed blessings 17:17:40 INFO - Cleaning up... 17:17:40 INFO - Return code: 0 17:17:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:41 INFO - Reading from file tmpfile_stdout 17:17:41 INFO - Current package versions: 17:17:41 INFO - blessings == 1.5.1 17:17:41 INFO - blobuploader == 1.2.4 17:17:41 INFO - docopt == 0.6.1 17:17:41 INFO - manifestparser == 1.1 17:17:41 INFO - mozInstall == 1.12 17:17:41 INFO - mozcrash == 0.16 17:17:41 INFO - mozdebug == 0.1 17:17:41 INFO - mozdevice == 0.47 17:17:41 INFO - mozfile == 1.2 17:17:41 INFO - mozhttpd == 0.7 17:17:41 INFO - mozinfo == 0.9 17:17:41 INFO - mozleak == 0.1 17:17:41 INFO - mozlog == 3.0 17:17:41 INFO - moznetwork == 0.27 17:17:41 INFO - mozprocess == 0.22 17:17:41 INFO - mozprofile == 0.27 17:17:41 INFO - mozrunner == 6.11 17:17:41 INFO - mozscreenshot == 0.1 17:17:41 INFO - mozsystemmonitor == 0.0 17:17:41 INFO - moztest == 0.7 17:17:41 INFO - mozversion == 1.4 17:17:41 INFO - psutil == 3.1.1 17:17:41 INFO - requests == 1.2.3 17:17:41 INFO - wsgiref == 0.1.2 17:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x100875490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100852228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd279589ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/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.DCC1IG21Lx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:17:41 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 17:17:41 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 17:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:41 INFO - 'HOME': '/Users/cltbld', 17:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:41 INFO - 'LOGNAME': 'cltbld', 17:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:41 INFO - 'MOZ_NO_REMOTE': '1', 17:17:41 INFO - 'NO_EM_RESTART': '1', 17:17:41 INFO - 'PAGER': '/bin/cat', 17:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:41 INFO - 'PWD': '/builds/slave/test', 17:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:41 INFO - 'SHELL': '/bin/bash', 17:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:17:41 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:41 INFO - 'USER': 'cltbld', 17:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:41 INFO - 'XPC_FLAGS': '0x0', 17:17:41 INFO - 'XPC_SERVICE_NAME': '0', 17:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 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)) 17:17:41 INFO - Cleaning up... 17:17:41 INFO - Return code: 0 17:17:41 INFO - Running post-action listener: _resource_record_post_action 17:17:41 INFO - Running post-action listener: _start_resource_monitoring 17:17:41 INFO - Starting resource monitoring. 17:17:41 INFO - ##### 17:17:41 INFO - ##### Running install step. 17:17:41 INFO - ##### 17:17:41 INFO - Running pre-action listener: _resource_record_pre_action 17:17:41 INFO - Running main action method: install 17:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:41 INFO - Reading from file tmpfile_stdout 17:17:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:41 INFO - Reading from file tmpfile_stdout 17:17:41 INFO - Output received: 17:17:41 INFO - Usage: mozinstall [options] installer 17:17:41 INFO - Options: 17:17:41 INFO - -h, --help show this help message and exit 17:17:41 INFO - -d DEST, --destination=DEST 17:17:41 INFO - Directory to install application into. [default: 17:17:41 INFO - "/builds/slave/test"] 17:17:41 INFO - --app=APP Application being installed. [default: firefox] 17:17:41 INFO - mkdir: /builds/slave/test/build/application 17:17:41 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'] 17:17:41 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 17:18:11 INFO - Reading from file tmpfile_stdout 17:18:11 INFO - Output received: 17:18:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:18:11 INFO - Running post-action listener: _resource_record_post_action 17:18:11 INFO - ##### 17:18:11 INFO - ##### Running run-tests step. 17:18:11 INFO - ##### 17:18:11 INFO - Running pre-action listener: _resource_record_pre_action 17:18:11 INFO - Running main action method: run_tests 17:18:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:11 INFO - 2015-11-19 17:18:11.709 screenresolution[1647:7584] starting screenresolution argv=screenresolution get 17:18:11 INFO - 2015-11-19 17:18:11.712 screenresolution[1647:7584] Display 0: 1600x1200x32@60 17:18:11 INFO - 2015-11-19 17:18:11.719 screenresolution[1648:7587] starting screenresolution argv=screenresolution list 17:18:11 INFO - Available Modes on Display 0 17:18:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:11 INFO - Intel Iris: 17:18:11 INFO - Chipset Model: Intel Iris 17:18:11 INFO - Type: GPU 17:18:11 INFO - Bus: Built-In 17:18:11 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:11 INFO - Vendor: Intel (0x8086) 17:18:11 INFO - Device ID: 0x0a2e 17:18:11 INFO - Revision ID: 0x0009 17:18:11 INFO - Displays: 17:18:11 INFO - Display: 17:18:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:11 INFO - Display Serial Number: 1600x1200 60 17:18:11 INFO - Main Display: Yes 17:18:11 INFO - Mirror: Off 17:18:11 INFO - Online: Yes 17:18:11 INFO - Rotation: Supported 17:18:11 INFO - Return code: 0 17:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:11 INFO - Python 2.7.3 17:18:11 INFO - Return code: 0 17:18:11 INFO - grabbing minidump binary from tooltool 17:18:11 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')]} 17:18:11 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 0x1007999f0>, '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 0x1004f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10078c8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:11 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 17:18:11 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 17:18:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:12 INFO - Return code: 0 17:18:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:18:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:18:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost'] in /builds/slave/test/build 17:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --webServer localhost 17:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BtwGIuNJvc/Render', 17:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:12 INFO - 'HOME': '/Users/cltbld', 17:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:12 INFO - 'LOGNAME': 'cltbld', 17:18:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:12 INFO - 'MOZ_NO_REMOTE': '1', 17:18:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:12 INFO - 'NO_EM_RESTART': '1', 17:18:12 INFO - 'PAGER': '/bin/cat', 17:18:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:12 INFO - 'PWD': '/builds/slave/test', 17:18:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:12 INFO - 'SHELL': '/bin/bash', 17:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DCC1IG21Lx/Listeners', 17:18:12 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 17:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:12 INFO - 'USER': 'cltbld', 17:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:12 INFO - 'XPC_FLAGS': '0x0', 17:18:12 INFO - 'XPC_SERVICE_NAME': '0', 17:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--webServer', 'localhost'] with output_timeout 3600 17:18:12 INFO - mozversion INFO | application_buildid: 20151119135111 17:18:12 INFO - mozversion INFO | application_changeset: 0920dee3c3036861bfe0f32342cdced4cabfb8df 17:18:12 INFO - mozversion INFO | application_display_name: Nightly 17:18:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:12 INFO - mozversion INFO | application_name: Firefox 17:18:12 INFO - mozversion INFO | application_remotingname: firefox 17:18:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:18:12 INFO - mozversion INFO | application_vendor: Mozilla 17:18:12 INFO - mozversion INFO | application_version: 45.0a1 17:18:12 INFO - mozversion INFO | platform_buildid: 20151119135111 17:18:12 INFO - mozversion INFO | platform_changeset: 0920dee3c3036861bfe0f32342cdced4cabfb8df 17:18:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:12 INFO - mozversion INFO | platform_version: 45.0a1 17:18:12 INFO - 2015-11-19 17:18:12,264 DEBUG : using testdate: 1447982292 17:18:12 INFO - 2015-11-19 17:18:12,264 DEBUG : actual date: 1447982292 17:18:12 INFO - 2015-11-19 17:18:12,606 INFO : starting webserver on 'localhost:49262' 17:18:12 INFO - 2015-11-19 17:18:12,607 INFO : Starting test suite t-yosemite-r7-0053.e 17:18:12 INFO - 2015-11-19 17:18:12,607 INFO : Starting test dromaeo_css 17:18:12 INFO - 2015-11-19 17:18:12,607 DEBUG : operating with platform_type : mac_ 17:18:12 INFO - 2015-11-19 17:18:12,608 INFO : Initialising browser for dromaeo_css test... 17:18:12 INFO - 2015-11-19 17:18:12,621 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpRhJkS3/profile http://localhost:49262/getInfo.html 17:18:15 INFO - 2015-11-19 17:18:15,593 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:18:15 INFO - 2015-11-19 17:18:15,593 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:18:15 INFO - 2015-11-19 17:18:15,593 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:18:15 INFO - 2015-11-19 17:18:15,593 DEBUG : BROWSER_OUTPUT: __metrics 17:18:16 INFO - 2015-11-19 17:18:16,205 INFO : Browser initialized. 17:18:16 INFO - 2015-11-19 17:18:16,205 INFO : Running cycle 1/1 for dromaeo_css test... 17:18:16 INFO - 2015-11-19 17:18:16,205 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpRhJkS3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:18:28 INFO - 2015-11-19 17:18:28,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 236953600 17:18:28 INFO - 2015-11-19 17:18:28,155 DEBUG : BROWSER_OUTPUT: 17:19:17 INFO - 2015-11-19 17:19:17,877 DEBUG : BROWSER_OUTPUT: 1447982357875 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] 17:21:29 INFO - 2015-11-19 17:21:29,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 17:21:30 INFO - 2015-11-19 17:21:30,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 255201280 17:21:30 INFO - 2015-11-19 17:21:30,245 DEBUG : BROWSER_OUTPUT: 17:24:32 INFO - 2015-11-19 17:24:32,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 17:24:32 INFO - 2015-11-19 17:24:32,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 265478144 17:24:32 INFO - 2015-11-19 17:24:32,791 DEBUG : BROWSER_OUTPUT: 17:27:34 INFO - 2015-11-19 17:27:34,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 17:27:34 INFO - 2015-11-19 17:27:34,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 266067968 17:27:34 INFO - 2015-11-19 17:27:34,959 DEBUG : BROWSER_OUTPUT: 17:30:36 INFO - 2015-11-19 17:30:36,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 17:30:37 INFO - 2015-11-19 17:30:37,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 269119488 17:30:37 INFO - 2015-11-19 17:30:37,168 DEBUG : BROWSER_OUTPUT: 17:33:39 INFO - 2015-11-19 17:33:39,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 17:33:40 INFO - 2015-11-19 17:33:40,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 272101376 17:33:40 INFO - 2015-11-19 17:33:40,202 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 17:36:42 INFO - 2015-11-19 17:36:42,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 274448384 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3489.4242449995754;3559.0924314299864;3594.82025898705;3612.8374223159954;3620.945685814713;6061.181740465041;6065.090236464533;6088.178095957044;6093.725782339794;6115.327313995463;5762.971185144069;5920.526357891369;5951.285845698522;5957.225560677106;6074.5140388768905;4447.332900064984;5269.314989051437;5379.919301210475;5424.267723857288;5503.889922201553;4919.926201106986;5393.406725260218;5460.31746031746;5476.342838859342;5544.140658197985;5227.869303267411;5270.367555893317;5339.492748188916;5387.272718183054;5424.538914192279;5386.649867758583;5397.325334333208;5403.594730395236;5444.237806707064;5449.809256676037;5378.193271009341;5383.67697938125;5394.541463975527;5406.567474602061;5432.6468779529205;5453.618246722731;5572.916406253868;5767.798127065533;5892.852678683067;6003.309619393738;5232.267482552407;6371.681415929232;6372.299047104815;6381.489480841568;6393.7762178324;6413.358664133596;6436.16329877113;6452;6460.870782584322;6485.124508191381;5918.585699001072;6014.158017877457;6050.2437195350585;6144.2319710036245;6149.538784591174;5541.944580554143;6414.230292364946;6536.836579085466;6593.571417857824;6600.768973085919;6104.908426373608;6315.115883776275;6322.272938612026;6347.301796802348;6357.777477788255;5069.315642388304;6339.175907132043;6350.7459701611415;6404.167458230493;6421.903671444932;4846.466888642317;6123.8162855114415;6306.085617585424;6358.554901156875;6366.808995730135;6193.1329613854095;6292.779752708633;6319.115323854664;6334.714937827809;6362.522810789209;5073.239014147907;5145.794168233228;5151.098557752378;5157.6647517911215;5203.479652034842;4497.64018878489;4515.435570553681;4528.5245049270015;4534.115847409724;4551.6813823032735;5837.124431335334;5949.375315591887;5995.580309378389;6056.36408177135;6057.60625559346;6365.522585806083;6396.616203027833;6400.039994000937;6402.423781859655;6446.67766611677;6070.423309785563;6115.602485838406;6119.357467465941;6125.571210015256;6142.508599312134;5448.809291674773;5472.097103977879;5549.1676248563035;5590.24531688225;5614.045612245846;6562.639054852029;6608.3391660834495;6651.268360480247;6656.767013154613;6658.800235992928;5888.175655408332;6442.516811239269;6448.774292899726;6457.483401327976;6487.837804054936;6357.96821015892;6458.54790164684;6476.481881449378;6560.573562718408;6616.172978377703;6314;6350.618962862243;6362.872742545216;6373.044043393528;6375.266844312963;6189.319174890668;6251.031090181029;6425.1968503937005;6435.517336199898;6443.742250309935;6133.478654314434;6227.314995350417;6329.778457753957;6346.492280617447;6347.460465860454;6295.811125666238;6306.400891915261;6323.588966717149;6327.209098862642;6333.240011198685;5952.5833191676165;6006.819795406145;6283.308836027942;6296.779612713533;6323.841903952254;6150.969245153925;6285.402886725754;6331.430171284606;6351.650659213788;6360.809175724736;6289.308176100534;6304.873902521832;6305.337939516285;6323.683815809283;6327.240731112296 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: |1;ext.html;515.2323038672374;571.5570432914493;580.0139762403915;587.2571197435245;600.4715850051954;41020;41874.53439129631;41912;41926.95182620436;42063;44619.33071003937;44704.55295447045;45008;45058.32412513815;45093.77453112738;9825.45959972203;9960.103590676837;10031.949840250825;10040.246981476383;10051.748706282327;9781.804363912717;9880.407175569453;9882.160016398615;9912.851307230398;9939.105480506752;9846.950765246163;9900.45547494891;9920.057594528509;9925.007499250089;10001.149902258281;9796.069373409515;9886.209103271722;9887.604495820158;9901.801963960717;9915.305928585001;9787.755306117404;9892.703218903445;9898.505074746306;9915.851262231072;9953.601855925826;41083.38374924379;41237.969050773674;41359.58640413587;41630.375544366856;41634;3213.7107660310685;3260.7065364117343;3440.7591468597207;3452.171478845084;3466.2027733621408;25744.485110297876;28296.858515707496;28783.56824647632;29173.85413072942;29413.705862941526;2531.3671582104475;2577.05937332874;2589.2361753282826;2596.8701564921867;2625.3567875870344;501960.99999999633;505055;506051;506116.4694176542;506513;50224.748876255384;55422.16866747002;63351;63902.680486597266;68505.65747171233;69582.65208674026;69876.6506167476;69958.9012329631;70301.2969870305;70334;16780.580485487717;16820.831791682172;16993.745093823603;17020.31918723262;17030.31878724862;10973.177011724152;12681.556145534862;12825.743485130432;12834.909032732136;12889.419976101099;20714.689279660815;20904.895475522524;20983.58032839365;21031.474213144487;21045.263415780373;7296.7081316746735;7466.104067511825;8920.197182253629;8926.86609700855;8953.462792232487;905.6377449020445;946.2855544064188;981.6809536900394;1011.529638717985;1048.3709774135457;29255.56116658252;29427.558586621217;29566.408671826444;30167.547486787716;30185.69814301873;1055.9260851740305;1083.853679753239;1100.7952947955491;1167.9240849344765;1222.1811386371153;14946;15069.849301507064;15180.696386072217;15377.692446151239;15473;462231;463174;467080;467576;468334;56361;57056.42943570594;57059.71470142706;57174;57217;1408.2606631518536;1414.476643641859;1438.8201474815648;1440.5750303660445;1579.6050987253186;27518;28681.42637147287;29993;30050;30722.84940054175;52063.69840754011;52307.47692523026;52376.47623523716;52382.95234095221;52463.68840779011;517914;519442;522890;524221;526689;31210.531842021934;32890.67109328972;33956.98129056132;33970.66029339675;33989.98030059102;34881.825590871886;44200.55799442093;45404.77297613623;45470.09059818719;46386.53613463957;36625.45061824128;37526;38066.23867522579;38290.8512744607;38565;36447.724329648336;36641;37071.258574827814;37347.25305493929;37452.43821342628;36314;36819.44770828493;37046.07384815401;37101.25797484089;37218.627813722596;25482.490350192522;30447.54328685116;32175.195620109684;32503;32638.857639982485;19167;19420;24315.635265471385;24615;24762.25713228606 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: |2;jquery.html;322.68538175279105;351.546505008539;356.96430356964305;360.97292703047276;365.444524323029;16576.917115414435;20326.491837704045;20559.794402055973;20786.584268314626;21396.4650883728;10411.843822342653;12584.433700483478;12666.556670516511;12737.299448530328;17068.14659267038;4665.696729712575;4695.600873925712;4763.833265835697;4770.4513980892125;4770.880727981794;4496.145732310867;4733.90532189356;5016.573591244749;5133.794648214086;5171.120909445403;5072.960043191137;5074.035933172704;5081.644284900059;5095.464976177504;5124;4984.401871775374;5109.131447653907;5116.079105760961;5122.692638441706;5133.922991155136;4300.956990430087;4312.159128969852;4314.654827613784;4336.479622445295;4352.412424322708;14238.85761142396;14267.215303158322;14483.927580362137;14554.126752394784;14597.978141530097;1578.8026496687914;1716.6652502761967;1913.7033759767119;1989.761228652571;2107.1992642795794;10203.336783109075;10216.94891525545;10425.374477531372;10546.736331591695;10587.364758114461;1566.443912411089;1575.944841930527;1615.273127092813;1663.8502534771928;1671.6489537197203;91022;98145;99056.50471747667;99686;99937;6748.527603067738;6771.289014653489;6790.626515541692;6833.760818371333;6841.692123854438;7532.13380461243;7648.158702542716;7652.7704168875025;7658.081030276291;7693.3459306248305;5700.914486282709;5721.056025755787;5727.31272247333;5742.7415766290615;5785.768569257267;6204.472619827366;6237.719302631393;6248.656323902229;6293.905591416133;6308.968455157695;2977.6129103216877;2997.640283166034;3002.5496175573403;3036.1195253376713;3048.3538889000133;1086.1148164246115;1095.1786160379716;1109.6504601050642;1136.4658610453073;1149.528693235786;439.9384086227931;442.710024933669;444.917690227309;456.5685427271197;478.19662966216396;11820.527178912918;12510.562130325578;12583.559575414816;12635;12667.746645067231;467.1218109953266;468.62978247184344;473.76548608439043;482.780334947598;488.07022621905327;6535.57518761279;6585.649941761927;6598.241202261705;6648;6648.634325112069;752991;758858;768756;775282;778296;112991.52563557767;114229;116223;117508;119727;516.2952569742275;518.0829931022145;519.498683770156;522.2949018824633;524.5436470270812;11875.881241187477;11933.403329833647;12013.279203247834;12057.397130143634;12359.949404300376;48907;49158;49774.75112624414;49803.501964979885;49950.50148495405;69174.65412673105;69877.65061174864;70052;70095.29904700888;70501.64749176221;6322.747090116344;6389.968050159905;6471.158749362553;6500.609963402211;6510.990796426561;12292.877071229532;12351.629451116482;12624.621261362174;12627;12682.843916534026;9109.04355042711;10400.687979360631;10498.685039448828;10851;11024.283421577571;3262.4453842847247;5591;9664.275179361717;10642.467876605984;10843.728906777395;9489.85765213536;10961.780764384508;11080.944595276973;11316;11431.485583148611;6409.7436102555375;6460.967695161494;6466.838329041623;6506.739730410731;6523.739050437929;10904.890951090387;10914.727131821768;11150.219484635998;11260.493277802354;11304.208705390543 17:36:42 INFO - 2015-11-19 17:36:42,855 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1504.6388866671996;1540.0836502281138;1844.206990993872;1885.0009494967667;1903.3243198664475;7533.585652789095;7666.693332266716;8272.931767058235;8678;8707.91292087079;8209.6305666245;8358.080611132771;8461.407701460901;8465.153484651531;8467.87298190526;2337.1118974789597;2363.409147713072;2370.644403339504;2371.051579368258;2377.7741114594087;2373.774491423321;2395.4969456414174;2423.0671191591186;2431.5866302728577;2445.4864478459544;2347.788699017088;2352.270796053229;2381.880905954704;2385.022140922222;2385.594448943675;2341.7072865891764;2351.0243249051623;2387.2599494156866;2388.0567175965484;2393.652920326552;2378.750231225714;2392.150786470795;2409.108629806965;2413;2414.5774489464447;8431.662733490653;8513.148685131498;8545.871811922827;8568.528730919797;8607.698730544402;4711.505291944331;5117.5650069744115;5198.116320225571;5213.244079608474;5222.2427747976335;3175.7618178636694;3202.711755941953;3215;3216.453202955503;3496.933435302232;1035.5288343803552;1037.994810025945;1056.5351245451977;1062.219268837404;1083.756154865157;11035.889641103566;11101.1674124441;11110.166737494801;11110.222284440093;11116.944415277952;4456.019675671347;4534.977325113419;4601.493835678073;4615.746133962664;4621.4223222097235;8276.586170691442;8659.956700216459;8763.737087887373;9195.034521375293;9195.908040919505;5132.8460146195675;5139.331886854685;5159.406668233126;5171.095058364771;5172.870678232999;4759.214729569651;4788.162071637449;4796.784144713496;4800.207965685692;4804.807807687654;3648.7628304160144;3649.50731651229;3660.853565857336;3681.208540163878;3687.6865466435115;1124.6007667277997;1152.757920836617;1155.9711007224719;1157.8074583179339;1158.5829101523445;1335.218896945298;1355.654308151415;1360.1091285208204;1362.7955806628886;1387.61840493865;7870.252326029018;8016.959915200387;8023.197680232047;8027.638756255982;8035.919640803634;503.2311425339933;511.56772527214446;513.1430511046561;517.2060886539144;517.5549027836058;5301.920471192935;5760.279965004374;5815.389384114692;6277.340879207617;6283.560150789401;7604.733834315773;10154.086132247985;10157.746056348651;10167.694969150938;10211.642592509375;8859;9557.522123893777;9924.206063514901;10110.140638045848;10117.038881306264;7896.407769417317;7917.366610671133;8026.197380261927;8029.718959836495;8030.19698030204;7831.84336313282;7832.099308579358;7842.058952925686;7873.330766884879;7919.16848730875;8740.825183496421;9080.818383632159;9172.31207659415;9264.53677316145;9315.673951411669;9203.079692030744;9373.812523749622;9446.95276523613;9490.478023708762;9628.566714497725;6983.9650801745665;7039;7049.695806275856;7062.788116356517;7074.893876591752;7865.842683146419;8047.034355877332;8113.959430202811;8150.673973041012;8162.6734930602115;6949.826254343682;7126.144862616519;7279.381252593589;7301.196868344584;7722.806929826799;7395.7041718330665;7416.295451932057;7453.142888567884;7493.250674932681;7524.17234104259;7548.622568871644;7555.584442855696;7575.8106047347055;7579.431542634215;7588.127365352834;6235.407636274546;6865.450763938973;6866.725330986705;6887.965560172167;6895.482838787011;6822.556533825285;6960;6960.930390696029;6988;7016.929830701832 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.6385412192466;326.1487517579118;336.7996042354798;338.9101887999682;341.9008487538612;5695;6768.560043597163;6889.5866248025095;6959.512834101615;7008.754693585725;6700.497462690293;6902.723891044365;6952;6967.198772141205;6983.546069505479;4643.976780116095;5120.411152717429;5144.717040562768;5154.92267615986;5155.587552995761;3882.3400021996326;4391.846285380012;4675.877789330553;5138.768755406016;5146.279520867081;4731.556875153077;4906.215005599105;5045.4450010499;5052.69683818972;5076.746162691869;3810.1427178884805;4471.463424389078;4757.548032936883;5074.452292050923;5085.23721441783;3413.300273443938;4220.32474804033;4238.109996900655;4322.8703138905885;4326.978365108186;6588.275289718127;6623.701933413008;6645.012992204687;6656.60060396373;6680.7327706891665;5041.294218809369;5802.303723553158;5934.703264836784;5993.7302821372705;6009.1587177795145;7215.927840721578;7376.815579610499;7396.852062958765;7435.553866768011;7444.9627751861435;4083.3670781028986;4856.3201151838775;4867.075255701441;4868.63485238605;4875.780589873464;7866.7639970800965;7879.724209652692;7899.565523896184;7921.326687231593;7924.08872979609;4797.784099715452;4917.852464426073;4928.236123400879;4958.206686930146;4965.503449655005;5036.899262014739;5048;5052.57053150479;5056.747162641853;5070.8225212117395;4498.05540836428;5978.641281523122;5978.910316345258;5997.880042399128;6002.969985150046;7261.128664560181;7282.635868206675;7468.925310746823;7479.990201322752;7491.400687945061;1448.992755036218;1715.5796829776784;1752.1852338662584;1757.5606098475382;1759.129231030648;1118.5302173087323;1124.0501775999267;1129.9887001130048;1134.5348407153028;1138.5218208352346;5157.948420515747;7042.542234754725;7060.576365418091;7067.469939754539;7087.468439867031;7750.302472777477;7782.49413788102;7785.649645765954;7822.139564647998;7822.765317040498;6878.69045892936;7043.92956070443;7050.717971281194;7073.540219885691;7083.6812343443635;3962.98943769337;4088.2436749200897;4094.058366575645;4096.795160241976;4140.109876376593;8009.159038301011;8151.470154440061;8167.83664326722;8172.67309307633;8204.794880127925;8094.923928906977;8121.878171827428;8131.512109273463;8175.427720059539;8182.631781569725;7132.500724949307;7546.434017448713;8115.75652730419;8156.877646835303;8164.714235001747;6120.990036643904;6834.726610935507;7364.889526657212;7878.409119315959;7897.881531776913;7239.927600723925;7484.625768711651;7658.042744656918;7721.112072111779;7735.381169506539;8126.553039582644;8146.307563857138;8151.266386025286;8170.264676179172;8206.958965205136;4643.558861908114;4961.8511444656715;4993.375828021497;5010.824621138243;5037.647364684437;6705.228898676714;7604.163542010264;7839.921600784147;7856.45004849655;7881.133075361591;7548.509346892434;7550.697972081055;7554.4334174936;7569.886451703339;7572.432067595063;7363.00599419093;7494.250574942462;7517.985072015208;7522.511036782592;7532.39740820744;7339.412846972336;7348.412127029932;7372.189059203591;7377.594232317274;7405.259474052552;7513.39892808585;7530.811729706801;7532.510386824839;7535.585542795199;7596.430267730053;7197.640117994184;7382.926170738224;7395.297446742551;7404.407647388303;7412.110546734426 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.2274999875132;780.980475488113;781.2031727637811;797.812514059196;812.899456911873;14915.552533423988;15107.471238506654;15155.318010689518;15324.38702451902;15333.233338333066;13754.58736237912;13843.861561384383;13872;13889.79165312521;14075.085119467252;937.3438592984904;958.793859320246;960.9135177833994;984.4487087231173;987.6493844685141;937.0535758883543;942.29328003997;949.2785483032876;952.4475804033644;957.4686049242667;961.6634178037701;974.3958745577717;976.6044751875502;977.7457860956167;983.6114734679797;951.4624237305935;951.9143277105094;954.8854137503474;956.6508224498077;957.9568919398644;701.242657929435;703.63762662229;711.8078118907866;721.9241979592119;722.6820199112374;14906.552803415914;14938.850611493855;14981.250937453193;15058.171800550965;15089.698206035819;10339.534720937576;10476.947615261875;10505.579776808918;10758.354498730101;11033.503492342863;9578.61685532578;9586;9591.520423978844;9894.406335619886;10117.494125293779;3139;3182.5703530023384;3198.8080715157166;3201.951970720441;3210.807351558914;79770;80822.19177808205;81264.78102828522;81814.77277840837;81879;6044.304904935989;6115.571909966348;6148.292946311231;6200.0699895016105;6338.7464501420345;12462.12765106452;12515.061370397256;12519.749605007848;12561.811572826415;12588.055895807667;6548.541602087808;6588.604683718992;6721.4958878084335;6832;6844.828879277959;4141.627253547195;4150.688698347636;4158.52762942946;4198.895027624334;4204.99080220751;3123.968760312368;3125.546795714609;3141.5601815745813;3150.102220867042;3151.0389331253728;487.5709375749318;494.0637491952729;503.40346689173447;510.28305231150296;510.9642325037212;561.7219476359228;573.6414740787009;578.837925380894;610.8167549735061;622.2904848019404;8440.493570385797;8569.614367353484;8659.610317535726;8669.609867555975;8742.82514349722;499.7751012044595;503.5769953239297;504.23104765233313;598.4344794169468;616.1620196532712;3664.285464334429;3973.106051138471;4265.936010959838;4281.914361712748;4336.501302350207;72594;92871;93401.5329923346;93725;93856.53071734597;57603.55991100256;78703.42593148105;84134;84202.15797841943;86118.56940715256;73970;74587;75877.86183207367;76063.61968190124;76480.85278720823;6920.5847649141215;8355.248027677539;8503.107173746668;8545.240238522621;8567.871481927652;52166.47833521616;52555.73722131365;52885;52921.412357629335;53627;58209;68904;71542;73382;75014.87477687949;7455.421471970471;7474.962625186839;7594.962025189839;7617.466777325534;7643.541387516767;11186.10511159089;11257.15571332137;11527.538898443969;11973.221740586834;12143.392830358624;10549.578016879239;10819.29674571182;10840.241183117107;10947.34315941046;10964.418686510593;10684.946575267073;10774.24580279373;10774.353538787384;10835.566577336818;10940.39827809478;10667.573297068031;10766.838497422701;10784.245102842726;10787.6224332148;10901;8583.098774628574;8654.956725216334;8694.739157825275;8840.955795220983;8855;9141.862872057058;9593.42439453635;9958.55186516623;9964.850527241952;9992.950035249778 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,319 17:36:42 INFO - 2015-11-19 17:36:42,859 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: __startTimestamp1447983402846__endTimestamp 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,860 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5908.70 Median:6142.51 stddev:664.73 (10.8%) stddev-sans-first:639.10 17:36:42 INFO - 2015-11-19 17:36:42,861 DEBUG : BROWSER_OUTPUT: Values: 3489.4 3559.1 3594.8 3612.8 3620.9 6061.2 6065.1 6088.2 6093.7 6115.3 5763.0 5920.5 5951.3 5957.2 6074.5 4447.3 5269.3 5379.9 5424.3 5503.9 4919.9 5393.4 5460.3 5476.3 5544.1 5227.9 5270.4 5339.5 5387.3 5424.5 5386.6 5397.3 5403.6 5444.2 5449.8 5378.2 5383.7 5394.5 5406.6 5432.6 5453.6 5572.9 5767.8 5892.9 6003.3 5232.3 6371.7 6372.3 6381.5 6393.8 6413.4 6436.2 6452.0 6460.9 6485.1 5918.6 6014.2 6050.2 6144.2 6149.5 5541.9 6414.2 6536.8 6593.6 6600.8 6104.9 6315.1 6322.3 6347.3 6357.8 5069.3 6339.2 6350.7 6404.2 6421.9 4846.5 6123.8 6306.1 6358.6 6366.8 6193.1 6292.8 6319.1 6334.7 6362.5 5073.2 5145.8 5151.1 5157.7 5203.5 4497.6 4515.4 4528.5 4534.1 4551.7 5837.1 5949.4 5995.6 6056.4 6057.6 6365.5 6396.6 6400.0 6402.4 6446.7 6070.4 6115.6 6119.4 6125.6 6142.5 5448.8 5472.1 5549.2 5590.2 5614.0 6562.6 6608.3 6651.3 6656.8 6658.8 5888.2 6442.5 6448.8 6457.5 6487.8 6358.0 6458.5 6476.5 6560.6 6616.2 6314.0 6350.6 6362.9 6373.0 6375.3 6189.3 6251.0 6425.2 6435.5 6443.7 6133.5 6227.3 6329.8 6346.5 6347.5 6295.8 6306.4 6323.6 6327.2 6333.2 5952.6 6006.8 6283.3 6296.8 6323.8 6151.0 6285.4 6331.4 6351.7 6360.8 6289.3 6304.9 6305.3 6323.7 6327.2 17:36:42 INFO - 2015-11-19 17:36:42,861 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,861 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:64522.71 Median:38427.93 stddev:132423.15 (344.6%) stddev-sans-first:132707.43 17:36:42 INFO - 2015-11-19 17:36:42,863 DEBUG : BROWSER_OUTPUT: Values: 515.2 571.6 580.0 587.3 600.5 41020.0 41874.5 41912.0 41927.0 42063.0 44619.3 44704.6 45008.0 45058.3 45093.8 9825.5 9960.1 10031.9 10040.2 10051.7 9781.8 9880.4 9882.2 9912.9 9939.1 9847.0 9900.5 9920.1 9925.0 10001.1 9796.1 9886.2 9887.6 9901.8 9915.3 9787.8 9892.7 9898.5 9915.9 9953.6 41083.4 41238.0 41359.6 41630.4 41634.0 3213.7 3260.7 3440.8 3452.2 3466.2 25744.5 28296.9 28783.6 29173.9 29413.7 2531.4 2577.1 2589.2 2596.9 2625.4 501961.0 505055.0 506051.0 506116.5 506513.0 50224.7 55422.2 63351.0 63902.7 68505.7 69582.7 69876.7 69958.9 70301.3 70334.0 16780.6 16820.8 16993.7 17020.3 17030.3 10973.2 12681.6 12825.7 12834.9 12889.4 20714.7 20904.9 20983.6 21031.5 21045.3 7296.7 7466.1 8920.2 8926.9 8953.5 905.6 946.3 981.7 1011.5 1048.4 29255.6 29427.6 29566.4 30167.5 30185.7 1055.9 1083.9 1100.8 1167.9 1222.2 14946.0 15069.8 15180.7 15377.7 15473.0 462231.0 463174.0 467080.0 467576.0 468334.0 56361.0 57056.4 57059.7 57174.0 57217.0 1408.3 1414.5 1438.8 1440.6 1579.6 27518.0 28681.4 29993.0 30050.0 30722.8 52063.7 52307.5 52376.5 52383.0 52463.7 517914.0 519442.0 522890.0 524221.0 526689.0 31210.5 32890.7 33957.0 33970.7 33990.0 34881.8 44200.6 45404.8 45470.1 46386.5 36625.5 37526.0 38066.2 38290.9 38565.0 36447.7 36641.0 37071.3 37347.3 37452.4 36314.0 36819.4 37046.1 37101.3 37218.6 25482.5 30447.5 32175.2 32503.0 32638.9 19167.0 19420.0 24315.6 24615.0 24762.3 17:36:42 INFO - 2015-11-19 17:36:42,863 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,863 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36519.38 Median:2561.13 stddev:126479.77 (4938.4%) stddev-sans-first:126805.37 17:36:42 INFO - 2015-11-19 17:36:42,864 DEBUG : BROWSER_OUTPUT: Values: 322.7 351.5 357.0 361.0 365.4 16576.9 20326.5 20559.8 20786.6 21396.5 10411.8 12584.4 12666.6 12737.3 17068.1 4665.7 4695.6 4763.8 4770.5 4770.9 4496.1 4733.9 5016.6 5133.8 5171.1 5073.0 5074.0 5081.6 5095.5 5124.0 4984.4 5109.1 5116.1 5122.7 5133.9 4301.0 4312.2 4314.7 4336.5 4352.4 14238.9 14267.2 14483.9 14554.1 14598.0 1578.8 1716.7 1913.7 1989.8 2107.2 10203.3 10216.9 10425.4 10546.7 10587.4 1566.4 1575.9 1615.3 1663.9 1671.6 91022.0 98145.0 99056.5 99686.0 99937.0 6748.5 6771.3 6790.6 6833.8 6841.7 7532.1 7648.2 7652.8 7658.1 7693.3 5700.9 5721.1 5727.3 5742.7 5785.8 6204.5 6237.7 6248.7 6293.9 6309.0 2977.6 2997.6 3002.5 3036.1 3048.4 1086.1 1095.2 1109.7 1136.5 1149.5 439.9 442.7 444.9 456.6 478.2 11820.5 12510.6 12583.6 12635.0 12667.7 467.1 468.6 473.8 482.8 488.1 6535.6 6585.6 6598.2 6648.0 6648.6 752991.0 758858.0 768756.0 775282.0 778296.0 112991.5 114229.0 116223.0 117508.0 119727.0 516.3 518.1 519.5 522.3 524.5 11875.9 11933.4 12013.3 12057.4 12359.9 48907.0 49158.0 49774.8 49803.5 49950.5 69174.7 69877.7 70052.0 70095.3 70501.6 6322.7 6390.0 6471.2 6500.6 6511.0 12292.9 12351.6 12624.6 12627.0 12682.8 9109.0 10400.7 10498.7 10851.0 11024.3 3262.4 5591.0 9664.3 10642.5 10843.7 9489.9 10961.8 11080.9 11316.0 11431.5 6409.7 6461.0 6466.8 6506.7 6523.7 10904.9 10914.7 11150.2 11260.5 11304.2 17:36:42 INFO - 2015-11-19 17:36:42,864 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,865 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5778.53 Median:5262.08 stddev:3014.47 (57.3%) stddev-sans-first:3005.81 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: Values: 1504.6 1540.1 1844.2 1885.0 1903.3 7533.6 7666.7 8272.9 8678.0 8707.9 8209.6 8358.1 8461.4 8465.2 8467.9 2337.1 2363.4 2370.6 2371.1 2377.8 2373.8 2395.5 2423.1 2431.6 2445.5 2347.8 2352.3 2381.9 2385.0 2385.6 2341.7 2351.0 2387.3 2388.1 2393.7 2378.8 2392.2 2409.1 2413.0 2414.6 8431.7 8513.1 8545.9 8568.5 8607.7 4711.5 5117.6 5198.1 5213.2 5222.2 3175.8 3202.7 3215.0 3216.5 3496.9 1035.5 1038.0 1056.5 1062.2 1083.8 11035.9 11101.2 11110.2 11110.2 11116.9 4456.0 4535.0 4601.5 4615.7 4621.4 8276.6 8660.0 8763.7 9195.0 9195.9 5132.8 5139.3 5159.4 5171.1 5172.9 4759.2 4788.2 4796.8 4800.2 4804.8 3648.8 3649.5 3660.9 3681.2 3687.7 1124.6 1152.8 1156.0 1157.8 1158.6 1335.2 1355.7 1360.1 1362.8 1387.6 7870.3 8017.0 8023.2 8027.6 8035.9 503.2 511.6 513.1 517.2 517.6 5301.9 5760.3 5815.4 6277.3 6283.6 7604.7 10154.1 10157.7 10167.7 10211.6 8859.0 9557.5 9924.2 10110.1 10117.0 7896.4 7917.4 8026.2 8029.7 8030.2 7831.8 7832.1 7842.1 7873.3 7919.2 8740.8 9080.8 9172.3 9264.5 9315.7 9203.1 9373.8 9447.0 9490.5 9628.6 6984.0 7039.0 7049.7 7062.8 7074.9 7865.8 8047.0 8114.0 8150.7 8162.7 6949.8 7126.1 7279.4 7301.2 7722.8 7395.7 7416.3 7453.1 7493.3 7524.2 7548.6 7555.6 7575.8 7579.4 7588.1 6235.4 6865.5 6866.7 6888.0 6895.5 6822.6 6960.0 6960.9 6988.0 7016.9 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6055.49 Median:6955.76 stddev:2002.08 (28.8%) stddev-sans-first:1960.96 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: Values: 325.6 326.1 336.8 338.9 341.9 5695.0 6768.6 6889.6 6959.5 7008.8 6700.5 6902.7 6952.0 6967.2 6983.5 4644.0 5120.4 5144.7 5154.9 5155.6 3882.3 4391.8 4675.9 5138.8 5146.3 4731.6 4906.2 5045.4 5052.7 5076.7 3810.1 4471.5 4757.5 5074.5 5085.2 3413.3 4220.3 4238.1 4322.9 4327.0 6588.3 6623.7 6645.0 6656.6 6680.7 5041.3 5802.3 5934.7 5993.7 6009.2 7215.9 7376.8 7396.9 7435.6 7445.0 4083.4 4856.3 4867.1 4868.6 4875.8 7866.8 7879.7 7899.6 7921.3 7924.1 4797.8 4917.9 4928.2 4958.2 4965.5 5036.9 5048.0 5052.6 5056.7 5070.8 4498.1 5978.6 5978.9 5997.9 6003.0 7261.1 7282.6 7468.9 7480.0 7491.4 1449.0 1715.6 1752.2 1757.6 1759.1 1118.5 1124.1 1130.0 1134.5 1138.5 5157.9 7042.5 7060.6 7067.5 7087.5 7750.3 7782.5 7785.6 7822.1 7822.8 6878.7 7043.9 7050.7 7073.5 7083.7 3963.0 4088.2 4094.1 4096.8 4140.1 8009.2 8151.5 8167.8 8172.7 8204.8 8094.9 8121.9 8131.5 8175.4 8182.6 7132.5 7546.4 8115.8 8156.9 8164.7 6121.0 6834.7 7364.9 7878.4 7897.9 7239.9 7484.6 7658.0 7721.1 7735.4 8126.6 8146.3 8151.3 8170.3 8207.0 4643.6 4961.9 4993.4 5010.8 5037.6 6705.2 7604.2 7839.9 7856.5 7881.1 7548.5 7550.7 7554.4 7569.9 7572.4 7363.0 7494.3 7518.0 7522.5 7532.4 7339.4 7348.4 7372.2 7377.6 7405.3 7513.4 7530.8 7532.5 7535.6 7596.4 7197.6 7382.9 7395.3 7404.4 7412.1 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: 17:36:42 INFO - 2015-11-19 17:36:42,866 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17900.72 Median:3411.18 stddev:26238.35 (769.2%) stddev-sans-first:26280.29 17:36:42 INFO - 2015-11-19 17:36:42,867 DEBUG : BROWSER_OUTPUT: Values: 732.2 781.0 781.2 797.8 812.9 14915.6 15107.5 15155.3 15324.4 15333.2 13754.6 13843.9 13872.0 13889.8 14075.1 937.3 958.8 960.9 984.4 987.6 937.1 942.3 949.3 952.4 957.5 961.7 974.4 976.6 977.7 983.6 951.5 951.9 954.9 956.7 958.0 701.2 703.6 711.8 721.9 722.7 14906.6 14938.9 14981.3 15058.2 15089.7 10339.5 10476.9 10505.6 10758.4 11033.5 9578.6 9586.0 9591.5 9894.4 10117.5 3139.0 3182.6 3198.8 3202.0 3210.8 79770.0 80822.2 81264.8 81814.8 81879.0 6044.3 6115.6 6148.3 6200.1 6338.7 12462.1 12515.1 12519.7 12561.8 12588.1 6548.5 6588.6 6721.5 6832.0 6844.8 4141.6 4150.7 4158.5 4198.9 4205.0 3124.0 3125.5 3141.6 3150.1 3151.0 487.6 494.1 503.4 510.3 511.0 561.7 573.6 578.8 610.8 622.3 8440.5 8569.6 8659.6 8669.6 8742.8 499.8 503.6 504.2 598.4 616.2 3664.3 3973.1 4265.9 4281.9 4336.5 72594.0 92871.0 93401.5 93725.0 93856.5 57603.6 78703.4 84134.0 84202.2 86118.6 73970.0 74587.0 75877.9 76063.6 76480.9 6920.6 8355.2 8503.1 8545.2 8567.9 52166.5 52555.7 52885.0 52921.4 53627.0 58209.0 68904.0 71542.0 73382.0 75014.9 7455.4 7475.0 7595.0 7617.5 7643.5 11186.1 11257.2 11527.5 11973.2 12143.4 10549.6 10819.3 10840.2 10947.3 10964.4 10684.9 10774.2 10774.4 10835.6 10940.4 10667.6 10766.8 10784.2 10787.6 10901.0 8583.1 8655.0 8694.7 8841.0 8855.0 9141.9 9593.4 9958.6 9964.9 9993.0 17:36:42 INFO - 2015-11-19 17:36:42,868 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:36:42 INFO - 2015-11-19 17:36:42,868 DEBUG : BROWSER_OUTPUT: 17:36:43 INFO - 2015-11-19 17:36:43,255 INFO : Browser exited with error code: 0 17:36:43 INFO - 2015-11-19 17:36:43,280 INFO : Completed test dromaeo_css (00:18:30) 17:36:43 INFO - 2015-11-19 17:36:43,280 INFO : Starting test kraken 17:36:43 INFO - 2015-11-19 17:36:43,280 DEBUG : operating with platform_type : mac_ 17:36:43 INFO - 2015-11-19 17:36:43,281 INFO : Initialising browser for kraken test... 17:36:43 INFO - 2015-11-19 17:36:43,293 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp3tl1jX/profile http://localhost:49262/getInfo.html 17:36:46 INFO - 2015-11-19 17:36:46,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:36:46 INFO - 2015-11-19 17:36:46,079 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:36:46 INFO - 2015-11-19 17:36:46,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:36:46 INFO - 2015-11-19 17:36:46,079 DEBUG : BROWSER_OUTPUT: __metrics 17:36:46 INFO - 2015-11-19 17:36:46,747 INFO : Browser initialized. 17:36:46 INFO - 2015-11-19 17:36:46,747 INFO : Running cycle 1/1 for kraken test... 17:36:46 INFO - 2015-11-19 17:36:46,747 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp3tl1jX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:36:58 INFO - 2015-11-19 17:36:58,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 235921408 17:36:58 INFO - 2015-11-19 17:36:58,606 DEBUG : BROWSER_OUTPUT: 17:37:01 INFO - 2015-11-19 17:37:01,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:01 INFO - 2015-11-19 17:37:01,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 249024512 17:37:01 INFO - 2015-11-19 17:37:01,940 DEBUG : BROWSER_OUTPUT: 17:37:04 INFO - 2015-11-19 17:37:04,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 17:37:05 INFO - 2015-11-19 17:37:05,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 258621440 17:37:05 INFO - 2015-11-19 17:37:05,120 DEBUG : BROWSER_OUTPUT: 17:37:08 INFO - 2015-11-19 17:37:08,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 17:37:09 INFO - 2015-11-19 17:37:09,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 260919296 17:37:09 INFO - 2015-11-19 17:37:09,080 DEBUG : BROWSER_OUTPUT: 17:37:10 INFO - 2015-11-19 17:37:10,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 17:37:11 INFO - 2015-11-19 17:37:11,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 261730304 17:37:11 INFO - 2015-11-19 17:37:11,575 DEBUG : BROWSER_OUTPUT: 17:37:13 INFO - 2015-11-19 17:37:13,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:14 INFO - 2015-11-19 17:37:14,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 264138752 17:37:14 INFO - 2015-11-19 17:37:14,125 DEBUG : BROWSER_OUTPUT: 17:37:17 INFO - 2015-11-19 17:37:17,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:17 INFO - 2015-11-19 17:37:17,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 262987776 17:37:17 INFO - 2015-11-19 17:37:17,602 DEBUG : BROWSER_OUTPUT: 17:37:20 INFO - 2015-11-19 17:37:20,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:21 INFO - 2015-11-19 17:37:21,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 265633792 17:37:21 INFO - 2015-11-19 17:37:21,402 DEBUG : BROWSER_OUTPUT: 17:37:24 INFO - 2015-11-19 17:37:24,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 17:37:24 INFO - 2015-11-19 17:37:24,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 263598080 17:37:24 INFO - 2015-11-19 17:37:24,959 DEBUG : BROWSER_OUTPUT: 17:37:26 INFO - 2015-11-19 17:37:26,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:27 INFO - 2015-11-19 17:37:27,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 264318976 17:37:27 INFO - 2015-11-19 17:37:27,061 DEBUG : BROWSER_OUTPUT: 17:37:28 INFO - 2015-11-19 17:37:28,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:29 INFO - 2015-11-19 17:37:29,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 264859648 17:37:29 INFO - 2015-11-19 17:37:29,459 DEBUG : BROWSER_OUTPUT: 17:37:31 INFO - 2015-11-19 17:37:31,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:32 INFO - 2015-11-19 17:37:32,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 264896512 17:37:32 INFO - 2015-11-19 17:37:32,282 DEBUG : BROWSER_OUTPUT: 17:37:34 INFO - 2015-11-19 17:37:34,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:35 INFO - 2015-11-19 17:37:35,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 264130560 17:37:35 INFO - 2015-11-19 17:37:35,479 DEBUG : BROWSER_OUTPUT: 17:37:37 INFO - 2015-11-19 17:37:37,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:38 INFO - 2015-11-19 17:37:38,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 264269824 17:37:38 INFO - 2015-11-19 17:37:38,499 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 264429568 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;106;114;112;113;125;112;114;119;113 17:37:40 INFO - 2015-11-19 17:37:40,381 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;169;151;139;151;121;143;140;124;156;121 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;193;190;199;198;231;210;265;275;200 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;65;67;108;59;82;86;59;110;62 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;78;76;109;75;79;76;106;75;77;110 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;88;79;76;122;132;130;86;86;86 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;89;90;125;150;130;130;142;151;131;135 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;92;82;109;107;139;123;147;112;83;76 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;60;58;59;59;59;59;64;58;58 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;66;67;67;73;68;69;68 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;78;94;108;108;110;109;85;87;106 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;102;120;125;126;129;146;131;113;116 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;140;138;141;138;127;142;143;140;138 17:37:40 INFO - 2015-11-19 17:37:40,382 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;67;70;59;57;62;87;76;67;67 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,838 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: __startTimestamp1447983460376__endTimestamp 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.97 (4.4%) stddev-sans-first:5.24 17:37:40 INFO - 2015-11-19 17:37:40,383 DEBUG : BROWSER_OUTPUT: Values: 116.0 106.0 114.0 112.0 113.0 125.0 112.0 114.0 119.0 113.0 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.00 stddev:16.00 (10.9%) stddev-sans-first:13.53 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: Values: 169.0 151.0 139.0 151.0 121.0 143.0 140.0 124.0 156.0 121.0 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:215.10 Median:205.00 stddev:31.42 (15.3%) stddev-sans-first:31.99 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: Values: 190.0 193.0 190.0 199.0 198.0 231.0 210.0 265.0 275.0 200.0 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.20 Median:64.50 stddev:19.54 (30.3%) stddev-sans-first:20.22 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 67.0 108.0 59.0 82.0 86.0 59.0 110.0 62.0 17:37:40 INFO - 2015-11-19 17:37:40,384 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.10 Median:76.00 stddev:15.42 (20.3%) stddev-sans-first:16.08 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 109.0 75.0 79.0 76.0 106.0 75.0 77.0 110.0 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:86.00 stddev:21.63 (25.2%) stddev-sans-first:22.73 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: Values: 89.0 88.0 79.0 76.0 122.0 132.0 130.0 86.0 86.0 86.0 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:127.30 Median:146.00 stddev:21.72 (14.9%) stddev-sans-first:18.08 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 125.0 150.0 130.0 130.0 142.0 151.0 131.0 135.0 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:107.00 Median:111.50 stddev:24.26 (21.8%) stddev-sans-first:25.11 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: Values: 92.0 82.0 109.0 107.0 139.0 123.0 147.0 112.0 83.0 76.0 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,385 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:1.81 (3.1%) stddev-sans-first:1.87 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: Values: 58.0 60.0 58.0 59.0 59.0 59.0 59.0 64.0 58.0 58.0 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:2.04 (3.0%) stddev-sans-first:2.06 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 66.0 67.0 67.0 73.0 68.0 69.0 68.0 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:80.50 stddev:12.67 (15.7%) stddev-sans-first:12.42 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: Values: 83.0 78.0 94.0 108.0 108.0 110.0 109.0 85.0 87.0 106.0 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:127.50 stddev:15.69 (12.3%) stddev-sans-first:12.45 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: Values: 156.0 102.0 120.0 125.0 126.0 129.0 146.0 131.0 113.0 116.0 17:37:40 INFO - 2015-11-19 17:37:40,386 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.50 stddev:4.49 (3.2%) stddev-sans-first:4.69 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 138.0 141.0 138.0 127.0 142.0 143.0 140.0 138.0 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:8.72 (13.0%) stddev-sans-first:9.15 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: Values: 64.0 67.0 70.0 59.0 57.0 62.0 87.0 76.0 67.0 67.0 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:37:40 INFO - 2015-11-19 17:37:40,388 DEBUG : BROWSER_OUTPUT: 17:37:41 INFO - 2015-11-19 17:37:41,180 INFO : Browser exited with error code: 0 17:37:41 INFO - 2015-11-19 17:37:41,225 INFO : Completed test kraken (00:00:57) 17:37:41 INFO - 2015-11-19 17:37:41,225 INFO : Starting test v8_7 17:37:41 INFO - 2015-11-19 17:37:41,225 DEBUG : operating with platform_type : mac_ 17:37:41 INFO - 2015-11-19 17:37:41,225 INFO : Initialising browser for v8_7 test... 17:37:41 INFO - 2015-11-19 17:37:41,237 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp_AIpGt/profile http://localhost:49262/getInfo.html 17:37:43 INFO - 2015-11-19 17:37:43,994 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:37:43 INFO - 2015-11-19 17:37:43,994 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:37:43 INFO - 2015-11-19 17:37:43,994 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:37:43 INFO - 2015-11-19 17:37:43,994 DEBUG : BROWSER_OUTPUT: __metrics 17:37:44 INFO - 2015-11-19 17:37:44,580 INFO : Browser initialized. 17:37:44 INFO - 2015-11-19 17:37:44,580 INFO : Running cycle 1/1 for v8_7 test... 17:37:44 INFO - 2015-11-19 17:37:44,580 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmp_AIpGt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:37:56 INFO - 2015-11-19 17:37:56,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 236802048 17:37:56 INFO - 2015-11-19 17:37:56,568 DEBUG : BROWSER_OUTPUT: 17:38:17 INFO - 2015-11-19 17:38:17,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/v8_7/run.html (next: http://localhost:49262/tests/v8_7/run.html) 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 247787520 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:38:18 INFO - 2015-11-19 17:38:18,239 DEBUG : BROWSER_OUTPUT: |0;Richards;146.177459435755 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;158.4534938995405 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4826.923076923077 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |4;RayTrace;961.5384615384615 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |5;Earley;738.0073800738007 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |6;Boyer;13276.315789473685 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |7;RegExp;26500 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |8;Splay;580.046403712297 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: __startTimestamp1447983498232__endTimestamp 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,240 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.18 Median:146.18 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: Values: 146.2 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:158.45 Median:158.45 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: Values: 158.5 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: Values: 279.8 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: Values: 4826.9 17:38:18 INFO - 2015-11-19 17:38:18,241 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:961.54 Median:961.54 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: Values: 961.5 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.01 Median:738.01 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: Values: 738.0 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13276.32 Median:13276.32 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: Values: 13276.3 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: Values: 26500.0 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.05 Median:580.05 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: Values: 580.0 17:38:18 INFO - 2015-11-19 17:38:18,242 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,243 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-19 17:38:18,243 DEBUG : BROWSER_OUTPUT: Values: 4509.0 17:38:18 INFO - 2015-11-19 17:38:18,243 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:38:18 INFO - 2015-11-19 17:38:18,243 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-19 17:38:18,876 INFO : Browser exited with error code: 0 17:38:18 INFO - 2015-11-19 17:38:18,894 INFO : Completed test v8_7 (00:00:37) 17:38:19 INFO - 2015-11-19 17:38:19,303 INFO : Completed test suite (00:20:06) 17:38:19 INFO - 2015-11-19 17:38:19,303 DEBUG : Working with test: dromaeo_css 17:38:19 INFO - 2015-11-19 17:38:19,303 DEBUG : Generating results file: dromaeo_css 17:38:19 INFO - 2015-11-19 17:38:19,304 DEBUG : Working with test: kraken 17:38:19 INFO - 2015-11-19 17:38:19,304 DEBUG : Generating results file: kraken 17:38:19 INFO - 2015-11-19 17:38:19,305 INFO : javascript benchmark 17:38:19 INFO - 2015-11-19 17:38:19,305 DEBUG : Working with test: v8_7 17:38:19 INFO - 2015-11-19 17:38:19,305 DEBUG : Generating results file: v8_7 17:38:19 INFO - 2015-11-19 17:38:19,305 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:19 INFO - 2015-11-19 17:38:19,690 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 17:38:19 INFO - 2015-11-19 17:38:19,690 DEBUG : process_Request line: dromaeo_css 7209.83 graph.html#tests=[[72,64,61]] 17:38:19 INFO - 2015-11-19 17:38:19,691 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:19 INFO - 2015-11-19 17:38:19,719 DEBUG : process_Request line: kraken 1521.60 graph.html#tests=[[232,64,61]] 17:38:19 INFO - 2015-11-19 17:38:19,719 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:19 INFO - 2015-11-19 17:38:19,745 DEBUG : process_Request line: v8_7 22311.30 graph.html#tests=[[230,64,61]] 17:38:19 INFO - 2015-11-19 17:38:19,746 INFO : javascript benchmark 17:38:19 INFO - 2015-11-19 17:38:19,748 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3489.4242449995754, 3559.0924314299864, 3594.82025898705, 3612.8374223159954, 3620.945685814713, 6061.181740465041, 6065.090236464533, 6088.178095957044, 6093.725782339794, 6115.327313995463, 5762.971185144069, 5920.526357891369, 5951.285845698522, 5957.225560677106, 6074.5140388768905, 4447.332900064984, 5269.314989051437, 5379.919301210475, 5424.267723857288, 5503.889922201553, 4919.926201106986, 5393.406725260218, 5460.31746031746, 5476.342838859342, 5544.140658197985, 5227.869303267411, 5270.367555893317, 5339.492748188916, 5387.272718183054, 5424.538914192279, 5386.649867758583, 5397.325334333208, 5403.594730395236, 5444.237806707064, 5449.809256676037, 5378.193271009341, 5383.67697938125, 5394.541463975527, 5406.567474602061, 5432.6468779529205, 5453.618246722731, 5572.916406253868, 5767.798127065533, 5892.852678683067, 6003.309619393738, 5232.267482552407, 6371.681415929232, 6372.299047104815, 6381.489480841568, 6393.7762178324, 6413.358664133596, 6436.16329877113, 6452.0, 6460.870782584322, 6485.124508191381, 5918.585699001072, 6014.158017877457, 6050.2437195350585, 6144.2319710036245, 6149.538784591174, 5541.944580554143, 6414.230292364946, 6536.836579085466, 6593.571417857824, 6600.768973085919, 6104.908426373608, 6315.115883776275, 6322.272938612026, 6347.301796802348, 6357.777477788255, 5069.315642388304, 6339.175907132043, 6350.7459701611415, 6404.167458230493, 6421.903671444932, 4846.466888642317, 6123.8162855114415, 6306.085617585424, 6358.554901156875, 6366.808995730135, 6193.1329613854095, 6292.779752708633, 6319.115323854664, 6334.714937827809, 6362.522810789209, 5073.239014147907, 5145.794168233228, 5151.098557752378, 5157.6647517911215, 5203.479652034842, 4497.64018878489, 4515.435570553681, 4528.5245049270015, 4534.115847409724, 4551.6813823032735, 5837.124431335334, 5949.375315591887, 5995.580309378389, 6056.36408177135, 6057.60625559346, 6365.522585806083, 6396.616203027833, 6400.039994000937, 6402.423781859655, 6446.67766611677, 6070.423309785563, 6115.602485838406, 6119.357467465941, 6125.571210015256, 6142.508599312134, 5448.809291674773, 5472.097103977879, 5549.1676248563035, 5590.24531688225, 5614.045612245846, 6562.639054852029, 6608.3391660834495, 6651.268360480247, 6656.767013154613, 6658.800235992928, 5888.175655408332, 6442.516811239269, 6448.774292899726, 6457.483401327976, 6487.837804054936, 6357.96821015892, 6458.54790164684, 6476.481881449378, 6560.573562718408, 6616.172978377703, 6314.0, 6350.618962862243, 6362.872742545216, 6373.044043393528, 6375.266844312963, 6189.319174890668, 6251.031090181029, 6425.1968503937005, 6435.517336199898, 6443.742250309935, 6133.478654314434, 6227.314995350417, 6329.778457753957, 6346.492280617447, 6347.460465860454, 6295.811125666238, 6306.400891915261, 6323.588966717149, 6327.209098862642, 6333.240011198685, 5952.5833191676165, 6006.819795406145, 6283.308836027942, 6296.779612713533, 6323.841903952254, 6150.969245153925, 6285.402886725754, 6331.430171284606, 6351.650659213788, 6360.809175724736, 6289.308176100534, 6304.873902521832, 6305.337939516285, 6323.683815809283, 6327.240731112296], "unit": "ms", "name": "dojo.html", "value": 5869.015892177758}, {"lowerIsBetter": false, "replicates": [515.2323038672374, 571.5570432914493, 580.0139762403915, 587.2571197435245, 600.4715850051954, 41020.0, 41874.53439129631, 41912.0, 41926.95182620436, 42063.0, 44619.33071003937, 44704.55295447045, 45008.0, 45058.32412513815, 45093.77453112738, 9825.45959972203, 9960.103590676837, 10031.949840250825, 10040.246981476383, 10051.748706282327, 9781.804363912717, 9880.407175569453, 9882.160016398615, 9912.851307230398, 9939.105480506752, 9846.950765246163, 9900.45547494891, 9920.057594528509, 9925.007499250089, 10001.149902258281, 9796.069373409515, 9886.209103271722, 9887.604495820158, 9901.801963960717, 9915.305928585001, 9787.755306117404, 9892.703218903445, 9898.505074746306, 9915.851262231072, 9953.601855925826, 41083.38374924379, 41237.969050773674, 41359.58640413587, 41630.375544366856, 41634.0, 3213.7107660310685, 3260.7065364117343, 3440.7591468597207, 3452.171478845084, 3466.2027733621408, 25744.485110297876, 28296.858515707496, 28783.56824647632, 29173.85413072942, 29413.705862941526, 2531.3671582104475, 2577.05937332874, 2589.2361753282826, 2596.8701564921867, 2625.3567875870344, 501960.99999999633, 505055.0, 506051.0, 506116.4694176542, 506513.0, 50224.748876255384, 55422.16866747002, 63351.0, 63902.680486597266, 68505.65747171233, 69582.65208674026, 69876.6506167476, 69958.9012329631, 70301.2969870305, 70334.0, 16780.580485487717, 16820.831791682172, 16993.745093823603, 17020.31918723262, 17030.31878724862, 10973.177011724152, 12681.556145534862, 12825.743485130432, 12834.909032732136, 12889.419976101099, 20714.689279660815, 20904.895475522524, 20983.58032839365, 21031.474213144487, 21045.263415780373, 7296.7081316746735, 7466.104067511825, 8920.197182253629, 8926.86609700855, 8953.462792232487, 905.6377449020445, 946.2855544064188, 981.6809536900394, 1011.529638717985, 1048.3709774135457, 29255.56116658252, 29427.558586621217, 29566.408671826444, 30167.547486787716, 30185.69814301873, 1055.9260851740305, 1083.853679753239, 1100.7952947955491, 1167.9240849344765, 1222.1811386371153, 14946.0, 15069.849301507064, 15180.696386072217, 15377.692446151239, 15473.0, 462231.0, 463174.0, 467080.0, 467576.0, 468334.0, 56361.0, 57056.42943570594, 57059.71470142706, 57174.0, 57217.0, 1408.2606631518536, 1414.476643641859, 1438.8201474815648, 1440.5750303660445, 1579.6050987253186, 27518.0, 28681.42637147287, 29993.0, 30050.0, 30722.84940054175, 52063.69840754011, 52307.47692523026, 52376.47623523716, 52382.95234095221, 52463.68840779011, 517914.0, 519442.0, 522890.0, 524221.0, 526689.0, 31210.531842021934, 32890.67109328972, 33956.98129056132, 33970.66029339675, 33989.98030059102, 34881.825590871886, 44200.55799442093, 45404.77297613623, 45470.09059818719, 46386.53613463957, 36625.45061824128, 37526.0, 38066.23867522579, 38290.8512744607, 38565.0, 36447.724329648336, 36641.0, 37071.258574827814, 37347.25305493929, 37452.43821342628, 36314.0, 36819.44770828493, 37046.07384815401, 37101.25797484089, 37218.627813722596, 25482.490350192522, 30447.54328685116, 32175.195620109684, 32503.0, 32638.857639982485, 19167.0, 19420.0, 24315.635265471385, 24615.0, 24762.25713228606], "unit": "ms", "name": "ext.html", "value": 19964.908136127364}, {"lowerIsBetter": false, "replicates": [322.68538175279105, 351.546505008539, 356.96430356964305, 360.97292703047276, 365.444524323029, 16576.917115414435, 20326.491837704045, 20559.794402055973, 20786.584268314626, 21396.4650883728, 10411.843822342653, 12584.433700483478, 12666.556670516511, 12737.299448530328, 17068.14659267038, 4665.696729712575, 4695.600873925712, 4763.833265835697, 4770.4513980892125, 4770.880727981794, 4496.145732310867, 4733.90532189356, 5016.573591244749, 5133.794648214086, 5171.120909445403, 5072.960043191137, 5074.035933172704, 5081.644284900059, 5095.464976177504, 5124.0, 4984.401871775374, 5109.131447653907, 5116.079105760961, 5122.692638441706, 5133.922991155136, 4300.956990430087, 4312.159128969852, 4314.654827613784, 4336.479622445295, 4352.412424322708, 14238.85761142396, 14267.215303158322, 14483.927580362137, 14554.126752394784, 14597.978141530097, 1578.8026496687914, 1716.6652502761967, 1913.7033759767119, 1989.761228652571, 2107.1992642795794, 10203.336783109075, 10216.94891525545, 10425.374477531372, 10546.736331591695, 10587.364758114461, 1566.443912411089, 1575.944841930527, 1615.273127092813, 1663.8502534771928, 1671.6489537197203, 91022.0, 98145.0, 99056.50471747667, 99686.0, 99937.0, 6748.527603067738, 6771.289014653489, 6790.626515541692, 6833.760818371333, 6841.692123854438, 7532.13380461243, 7648.158702542716, 7652.7704168875025, 7658.081030276291, 7693.3459306248305, 5700.914486282709, 5721.056025755787, 5727.31272247333, 5742.7415766290615, 5785.768569257267, 6204.472619827366, 6237.719302631393, 6248.656323902229, 6293.905591416133, 6308.968455157695, 2977.6129103216877, 2997.640283166034, 3002.5496175573403, 3036.1195253376713, 3048.3538889000133, 1086.1148164246115, 1095.1786160379716, 1109.6504601050642, 1136.4658610453073, 1149.528693235786, 439.9384086227931, 442.710024933669, 444.917690227309, 456.5685427271197, 478.19662966216396, 11820.527178912918, 12510.562130325578, 12583.559575414816, 12635.0, 12667.746645067231, 467.1218109953266, 468.62978247184344, 473.76548608439043, 482.780334947598, 488.07022621905327, 6535.57518761279, 6585.649941761927, 6598.241202261705, 6648.0, 6648.634325112069, 752991.0, 758858.0, 768756.0, 775282.0, 778296.0, 112991.52563557767, 114229.0, 116223.0, 117508.0, 119727.0, 516.2952569742275, 518.0829931022145, 519.498683770156, 522.2949018824633, 524.5436470270812, 11875.881241187477, 11933.403329833647, 12013.279203247834, 12057.397130143634, 12359.949404300376, 48907.0, 49158.0, 49774.75112624414, 49803.501964979885, 49950.50148495405, 69174.65412673105, 69877.65061174864, 70052.0, 70095.29904700888, 70501.64749176221, 6322.747090116344, 6389.968050159905, 6471.158749362553, 6500.609963402211, 6510.990796426561, 12292.877071229532, 12351.629451116482, 12624.621261362174, 12627.0, 12682.843916534026, 9109.04355042711, 10400.687979360631, 10498.685039448828, 10851.0, 11024.283421577571, 3262.4453842847247, 5591.0, 9664.275179361717, 10642.467876605984, 10843.728906777395, 9489.85765213536, 10961.780764384508, 11080.944595276973, 11316.0, 11431.485583148611, 6409.7436102555375, 6460.967695161494, 6466.838329041623, 6506.739730410731, 6523.739050437929, 10904.890951090387, 10914.727131821768, 11150.219484635998, 11260.493277802354, 11304.208705390543], "unit": "ms", "name": "jquery.html", "value": 7298.07575130311}, {"lowerIsBetter": false, "replicates": [1504.6388866671996, 1540.0836502281138, 1844.206990993872, 1885.0009494967667, 1903.3243198664475, 7533.585652789095, 7666.693332266716, 8272.931767058235, 8678.0, 8707.91292087079, 8209.6305666245, 8358.080611132771, 8461.407701460901, 8465.153484651531, 8467.87298190526, 2337.1118974789597, 2363.409147713072, 2370.644403339504, 2371.051579368258, 2377.7741114594087, 2373.774491423321, 2395.4969456414174, 2423.0671191591186, 2431.5866302728577, 2445.4864478459544, 2347.788699017088, 2352.270796053229, 2381.880905954704, 2385.022140922222, 2385.594448943675, 2341.7072865891764, 2351.0243249051623, 2387.2599494156866, 2388.0567175965484, 2393.652920326552, 2378.750231225714, 2392.150786470795, 2409.108629806965, 2413.0, 2414.5774489464447, 8431.662733490653, 8513.148685131498, 8545.871811922827, 8568.528730919797, 8607.698730544402, 4711.505291944331, 5117.5650069744115, 5198.116320225571, 5213.244079608474, 5222.2427747976335, 3175.7618178636694, 3202.711755941953, 3215.0, 3216.453202955503, 3496.933435302232, 1035.5288343803552, 1037.994810025945, 1056.5351245451977, 1062.219268837404, 1083.756154865157, 11035.889641103566, 11101.1674124441, 11110.166737494801, 11110.222284440093, 11116.944415277952, 4456.019675671347, 4534.977325113419, 4601.493835678073, 4615.746133962664, 4621.4223222097235, 8276.586170691442, 8659.956700216459, 8763.737087887373, 9195.034521375293, 9195.908040919505, 5132.8460146195675, 5139.331886854685, 5159.406668233126, 5171.095058364771, 5172.870678232999, 4759.214729569651, 4788.162071637449, 4796.784144713496, 4800.207965685692, 4804.807807687654, 3648.7628304160144, 3649.50731651229, 3660.853565857336, 3681.208540163878, 3687.6865466435115, 1124.6007667277997, 1152.757920836617, 1155.9711007224719, 1157.8074583179339, 1158.5829101523445, 1335.218896945298, 1355.654308151415, 1360.1091285208204, 1362.7955806628886, 1387.61840493865, 7870.252326029018, 8016.959915200387, 8023.197680232047, 8027.638756255982, 8035.919640803634, 503.2311425339933, 511.56772527214446, 513.1430511046561, 517.2060886539144, 517.5549027836058, 5301.920471192935, 5760.279965004374, 5815.389384114692, 6277.340879207617, 6283.560150789401, 7604.733834315773, 10154.086132247985, 10157.746056348651, 10167.694969150938, 10211.642592509375, 8859.0, 9557.522123893777, 9924.206063514901, 10110.140638045848, 10117.038881306264, 7896.407769417317, 7917.366610671133, 8026.197380261927, 8029.718959836495, 8030.19698030204, 7831.84336313282, 7832.099308579358, 7842.058952925686, 7873.330766884879, 7919.16848730875, 8740.825183496421, 9080.818383632159, 9172.31207659415, 9264.53677316145, 9315.673951411669, 9203.079692030744, 9373.812523749622, 9446.95276523613, 9490.478023708762, 9628.566714497725, 6983.9650801745665, 7039.0, 7049.695806275856, 7062.788116356517, 7074.893876591752, 7865.842683146419, 8047.034355877332, 8113.959430202811, 8150.673973041012, 8162.6734930602115, 6949.826254343682, 7126.144862616519, 7279.381252593589, 7301.196868344584, 7722.806929826799, 7395.7041718330665, 7416.295451932057, 7453.142888567884, 7493.250674932681, 7524.17234104259, 7548.622568871644, 7555.584442855696, 7575.8106047347055, 7579.431542634215, 7588.127365352834, 6235.407636274546, 6865.450763938973, 6866.725330986705, 6887.965560172167, 6895.482838787011, 6822.556533825285, 6960.0, 6960.930390696029, 6988.0, 7016.929830701832], "unit": "ms", "name": "mootools.html", "value": 4661.05034705211}, {"lowerIsBetter": false, "replicates": [325.6385412192466, 326.1487517579118, 336.7996042354798, 338.9101887999682, 341.9008487538612, 5695.0, 6768.560043597163, 6889.5866248025095, 6959.512834101615, 7008.754693585725, 6700.497462690293, 6902.723891044365, 6952.0, 6967.198772141205, 6983.546069505479, 4643.976780116095, 5120.411152717429, 5144.717040562768, 5154.92267615986, 5155.587552995761, 3882.3400021996326, 4391.846285380012, 4675.877789330553, 5138.768755406016, 5146.279520867081, 4731.556875153077, 4906.215005599105, 5045.4450010499, 5052.69683818972, 5076.746162691869, 3810.1427178884805, 4471.463424389078, 4757.548032936883, 5074.452292050923, 5085.23721441783, 3413.300273443938, 4220.32474804033, 4238.109996900655, 4322.8703138905885, 4326.978365108186, 6588.275289718127, 6623.701933413008, 6645.012992204687, 6656.60060396373, 6680.7327706891665, 5041.294218809369, 5802.303723553158, 5934.703264836784, 5993.7302821372705, 6009.1587177795145, 7215.927840721578, 7376.815579610499, 7396.852062958765, 7435.553866768011, 7444.9627751861435, 4083.3670781028986, 4856.3201151838775, 4867.075255701441, 4868.63485238605, 4875.780589873464, 7866.7639970800965, 7879.724209652692, 7899.565523896184, 7921.326687231593, 7924.08872979609, 4797.784099715452, 4917.852464426073, 4928.236123400879, 4958.206686930146, 4965.503449655005, 5036.899262014739, 5048.0, 5052.57053150479, 5056.747162641853, 5070.8225212117395, 4498.05540836428, 5978.641281523122, 5978.910316345258, 5997.880042399128, 6002.969985150046, 7261.128664560181, 7282.635868206675, 7468.925310746823, 7479.990201322752, 7491.400687945061, 1448.992755036218, 1715.5796829776784, 1752.1852338662584, 1757.5606098475382, 1759.129231030648, 1118.5302173087323, 1124.0501775999267, 1129.9887001130048, 1134.5348407153028, 1138.5218208352346, 5157.948420515747, 7042.542234754725, 7060.576365418091, 7067.469939754539, 7087.468439867031, 7750.302472777477, 7782.49413788102, 7785.649645765954, 7822.139564647998, 7822.765317040498, 6878.69045892936, 7043.92956070443, 7050.717971281194, 7073.540219885691, 7083.6812343443635, 3962.98943769337, 4088.2436749200897, 4094.058366575645, 4096.795160241976, 4140.109876376593, 8009.159038301011, 8151.470154440061, 8167.83664326722, 8172.67309307633, 8204.794880127925, 8094.923928906977, 8121.878171827428, 8131.512109273463, 8175.427720059539, 8182.631781569725, 7132.500724949307, 7546.434017448713, 8115.75652730419, 8156.877646835303, 8164.714235001747, 6120.990036643904, 6834.726610935507, 7364.889526657212, 7878.409119315959, 7897.881531776913, 7239.927600723925, 7484.625768711651, 7658.042744656918, 7721.112072111779, 7735.381169506539, 8126.553039582644, 8146.307563857138, 8151.266386025286, 8170.264676179172, 8206.958965205136, 4643.558861908114, 4961.8511444656715, 4993.375828021497, 5010.824621138243, 5037.647364684437, 6705.228898676714, 7604.163542010264, 7839.921600784147, 7856.45004849655, 7881.133075361591, 7548.509346892434, 7550.697972081055, 7554.4334174936, 7569.886451703339, 7572.432067595063, 7363.00599419093, 7494.250574942462, 7517.985072015208, 7522.511036782592, 7532.39740820744, 7339.412846972336, 7348.412127029932, 7372.189059203591, 7377.594232317274, 7405.259474052552, 7513.39892808585, 7530.811729706801, 7532.510386824839, 7535.585542795199, 7596.430267730053, 7197.640117994184, 7382.926170738224, 7395.297446742551, 7404.407647388303, 7412.110546734426], "unit": "ms", "name": "prototype.html", "value": 5386.411986251285}, {"lowerIsBetter": false, "replicates": [732.2274999875132, 780.980475488113, 781.2031727637811, 797.812514059196, 812.899456911873, 14915.552533423988, 15107.471238506654, 15155.318010689518, 15324.38702451902, 15333.233338333066, 13754.58736237912, 13843.861561384383, 13872.0, 13889.79165312521, 14075.085119467252, 937.3438592984904, 958.793859320246, 960.9135177833994, 984.4487087231173, 987.6493844685141, 937.0535758883543, 942.29328003997, 949.2785483032876, 952.4475804033644, 957.4686049242667, 961.6634178037701, 974.3958745577717, 976.6044751875502, 977.7457860956167, 983.6114734679797, 951.4624237305935, 951.9143277105094, 954.8854137503474, 956.6508224498077, 957.9568919398644, 701.242657929435, 703.63762662229, 711.8078118907866, 721.9241979592119, 722.6820199112374, 14906.552803415914, 14938.850611493855, 14981.250937453193, 15058.171800550965, 15089.698206035819, 10339.534720937576, 10476.947615261875, 10505.579776808918, 10758.354498730101, 11033.503492342863, 9578.61685532578, 9586.0, 9591.520423978844, 9894.406335619886, 10117.494125293779, 3139.0, 3182.5703530023384, 3198.8080715157166, 3201.951970720441, 3210.807351558914, 79770.0, 80822.19177808205, 81264.78102828522, 81814.77277840837, 81879.0, 6044.304904935989, 6115.571909966348, 6148.292946311231, 6200.0699895016105, 6338.7464501420345, 12462.12765106452, 12515.061370397256, 12519.749605007848, 12561.811572826415, 12588.055895807667, 6548.541602087808, 6588.604683718992, 6721.4958878084335, 6832.0, 6844.828879277959, 4141.627253547195, 4150.688698347636, 4158.52762942946, 4198.895027624334, 4204.99080220751, 3123.968760312368, 3125.546795714609, 3141.5601815745813, 3150.102220867042, 3151.0389331253728, 487.5709375749318, 494.0637491952729, 503.40346689173447, 510.28305231150296, 510.9642325037212, 561.7219476359228, 573.6414740787009, 578.837925380894, 610.8167549735061, 622.2904848019404, 8440.493570385797, 8569.614367353484, 8659.610317535726, 8669.609867555975, 8742.82514349722, 499.7751012044595, 503.5769953239297, 504.23104765233313, 598.4344794169468, 616.1620196532712, 3664.285464334429, 3973.106051138471, 4265.936010959838, 4281.914361712748, 4336.501302350207, 72594.0, 92871.0, 93401.5329923346, 93725.0, 93856.53071734597, 57603.55991100256, 78703.42593148105, 84134.0, 84202.15797841943, 86118.56940715256, 73970.0, 74587.0, 75877.86183207367, 76063.61968190124, 76480.85278720823, 6920.5847649141215, 8355.248027677539, 8503.107173746668, 8545.240238522621, 8567.871481927652, 52166.47833521616, 52555.73722131365, 52885.0, 52921.412357629335, 53627.0, 58209.0, 68904.0, 71542.0, 73382.0, 75014.87477687949, 7455.421471970471, 7474.962625186839, 7594.962025189839, 7617.466777325534, 7643.541387516767, 11186.10511159089, 11257.15571332137, 11527.538898443969, 11973.221740586834, 12143.392830358624, 10549.578016879239, 10819.29674571182, 10840.241183117107, 10947.34315941046, 10964.418686510593, 10684.946575267073, 10774.24580279373, 10774.353538787384, 10835.566577336818, 10940.39827809478, 10667.573297068031, 10766.838497422701, 10784.245102842726, 10787.6224332148, 10901.0, 8583.098774628574, 8654.956725216334, 8694.739157825275, 8840.955795220983, 8855.0, 9141.862872057058, 9593.42439453635, 9958.55186516623, 9964.850527241952, 9992.950035249778], "unit": "ms", "name": "yui.html", "value": 6541.705901186832}], "name": "dromaeo_css", "value": 7209.827845566237}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 106.0, 114.0, 112.0, 113.0, 125.0, 112.0, 114.0, 119.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [169.0, 151.0, 139.0, 151.0, 121.0, 143.0, 140.0, 124.0, 156.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [190.0, 193.0, 190.0, 199.0, 198.0, 231.0, 210.0, 265.0, 275.0, 200.0], "unit": "ms", "name": "audio-dft", "value": 215.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 108.0, 59.0, 82.0, 86.0, 59.0, 110.0, 62.0], "unit": "ms", "name": "audio-fft", "value": 76.2}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 109.0, 75.0, 79.0, 76.0, 106.0, 75.0, 77.0, 110.0], "unit": "ms", "name": "audio-oscillator", "value": 86.1}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 79.0, 76.0, 122.0, 132.0, 130.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 97.4}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 125.0, 150.0, 130.0, 130.0, 142.0, 151.0, 131.0, 135.0], "unit": "ms", "name": "imaging-darkroom", "value": 127.3}, {"lowerIsBetter": true, "replicates": [92.0, 82.0, 109.0, 107.0, 139.0, 123.0, 147.0, 112.0, 83.0, 76.0], "unit": "ms", "name": "imaging-desaturate", "value": 107.0}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 58.0, 59.0, 59.0, 59.0, 59.0, 64.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 73.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 78.0, 94.0, 108.0, 108.0, 110.0, 109.0, 85.0, 87.0, 106.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 96.8}, {"lowerIsBetter": true, "replicates": [156.0, 102.0, 120.0, 125.0, 126.0, 129.0, 146.0, 131.0, 113.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 138.0, 141.0, 138.0, 127.0, 142.0, 143.0, 140.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 70.0, 59.0, 57.0, 62.0, 87.0, 76.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1521.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.177459435755], "unit": "score", "name": "Richards", "value": 241.50098199999996}, {"lowerIsBetter": false, "replicates": [158.4534938995405], "unit": "score", "name": "DeltaBlue", "value": 417.27069800000004}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "Decrypt", "value": 55.145067729083685}, {"lowerIsBetter": false, "replicates": [961.5384615384615], "unit": "score", "name": "RayTrace", "value": 769.5885599999998}, {"lowerIsBetter": false, "replicates": [738.0073800738007], "unit": "score", "name": "Earley", "value": 903.057365}, {"lowerIsBetter": false, "replicates": [13276.315789473685], "unit": "score", "name": "Boyer", "value": 50.199393458870205}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [580.046403712297], "unit": "score", "name": "Splay", "value": 140.490484}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 22311.296629315606}]} 17:38:19 INFO - RETURN: dromaeo_css: 7209.83 17:38:19 INFO - RETURN: kraken: 1521.60 17:38:19 INFO - RETURN: v8_7: 22311.30 17:38:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "22311.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1521.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7209.83"}}} 17:38:19 INFO - Return code: 0 17:38:19 INFO - # TBPL SUCCESS # 17:38:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:19 INFO - 2015-11-19 17:38:19.846 screenresolution[1683:10774] starting screenresolution argv=screenresolution get 17:38:19 INFO - 2015-11-19 17:38:19.849 screenresolution[1683:10774] Display 0: 1600x1200x32@60 17:38:19 INFO - 2015-11-19 17:38:19.855 screenresolution[1684:10777] starting screenresolution argv=screenresolution list 17:38:19 INFO - Available Modes on Display 0 17:38:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:20 INFO - Intel Iris: 17:38:20 INFO - Chipset Model: Intel Iris 17:38:20 INFO - Type: GPU 17:38:20 INFO - Bus: Built-In 17:38:20 INFO - VRAM (Dynamic, Max): 1536 MB 17:38:20 INFO - Vendor: Intel (0x8086) 17:38:20 INFO - Device ID: 0x0a2e 17:38:20 INFO - Revision ID: 0x0009 17:38:20 INFO - Displays: 17:38:20 INFO - Display: 17:38:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:20 INFO - Display Serial Number: 1600x1200 60 17:38:20 INFO - Main Display: Yes 17:38:20 INFO - Mirror: Off 17:38:20 INFO - Online: Yes 17:38:20 INFO - Rotation: Supported 17:38:20 INFO - Return code: 0 17:38:20 INFO - Running post-action listener: _resource_record_post_action 17:38:20 INFO - Running post-run listener: _resource_record_post_run 17:38:21 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 33213952; Write bytes: 697255936; Read time: 346; Write time: 2137 17:38:21 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 344762880; Write bytes: 349067264; Read time: 26266; Write time: 711 17:38:21 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 31178240; Write bytes: 346451968; Read time: 324; Write time: 1421 17:38:21 INFO - Running post-run listener: _upload_blobber_files 17:38:21 INFO - Blob upload gear active. 17:38:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:38:21 INFO - Copying logs to upload dir... 17:38:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.498918 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-19 17:38:21.206732) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:38:21.210239) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009332 build_url: 'https://queue.taskcluster.net/v1/task/8L5Ls64XRY2XBK26TAEC7Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 17:38:21.233559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:38:21.233869) ========= 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.BtwGIuNJvc/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.DCC1IG21Lx/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005028 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 17:38:21.282715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 17:38:21.283040) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 17:38:21.283409) ========= ========= Total master_lag: 0.20 =========